builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-013 starttime: 1502014830.78 results: success (0) revision: fe6609d22dfdd710b11e3ac7773aff89f7a8d12c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-06 03:20:30.782485) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-06 03:20:30.782846) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-06 03:20:30.783114) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-06 03:20:30.828182) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 03:20:30.828457) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1502014223.252976-1781452603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-06 03:20:30-- 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% 99.9M=0s 2017-08-06 03:20:30 (99.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126487 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 03:20:30.980496) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 03:20:30.980777) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1502014223.252976-1781452603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023476 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 03:20:31.043414) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 03:20:31.043714) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fe6609d22dfdd710b11e3ac7773aff89f7a8d12c --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 fe6609d22dfdd710b11e3ac7773aff89f7a8d12c --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=9c3a94c35cc88655b05d2c08000001b2-1502014223.252976-1781452603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-06 03:20:31,053 truncating revision to first 12 chars 2017-08-06 03:20:31,053 Setting DEBUG logging. 2017-08-06 03:20:31,053 attempt 1/10 2017-08-06 03:20:31,053 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fe6609d22dfd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-06 03:20:31,555 unpacking tar archive at: mozilla-central-fe6609d22dfd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.917793 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 03:20:31.975637) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-06 03:20:31.975912) ========= script_repo_revision: fe6609d22dfdd710b11e3ac7773aff89f7a8d12c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-06 03:20:31.979302) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-06 03:20:31.979583) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-06 03:20:31.988479) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-08-06 03:20:31.988752) ========= /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=9c3a94c35cc88655b05d2c08000001b2-1502014223.252976-1781452603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:20:32 INFO - MultiFileLogger online at 20170806 03:20:32 in /builds/slave/test 03:20:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:20:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:20:32 INFO - {'append_to_log': False, 03:20:32 INFO - 'base_work_dir': '/builds/slave/test', 03:20:32 INFO - 'blob_upload_branch': 'Firefox', 03:20:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:20:32 INFO - 'branch': 'Firefox', 03:20:32 INFO - 'buildbot_json_path': 'buildprops.json', 03:20:32 INFO - 'code_coverage': False, 03:20:32 INFO - 'config_files': ('talos/linux_config.py',), 03:20:32 INFO - 'default_actions': ('clobber', 03:20:32 INFO - 'read-buildbot-config', 03:20:32 INFO - 'download-and-extract', 03:20:32 INFO - 'populate-webroot', 03:20:32 INFO - 'create-virtualenv', 03:20:32 INFO - 'install', 03:20:32 INFO - 'setup-mitmproxy', 03:20:32 INFO - 'run-tests'), 03:20:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:20:32 INFO - 'disable_ccov_upload': False, 03:20:32 INFO - 'download_minidump_stackwalk': True, 03:20:32 INFO - 'download_symbols': 'ondemand', 03:20:32 INFO - 'enable_stylo': False, 03:20:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:20:32 INFO - 'tooltool.py': '/tools/tooltool.py', 03:20:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:20:32 INFO - '/tools/misc-python/virtualenv.py')}, 03:20:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:20:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:20:32 INFO - 'gecko_profile': False, 03:20:32 INFO - 'gecko_profile_interval': 0, 03:20:32 INFO - 'installer_path': 'installer.exe', 03:20:32 INFO - 'log_level': 'info', 03:20:32 INFO - 'log_name': 'talos', 03:20:32 INFO - 'log_to_console': True, 03:20:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:20:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:20:32 INFO - 'opt_config_files': (), 03:20:32 INFO - 'pip_index': False, 03:20:32 INFO - 'suite': 'dromaeojs-e10s', 03:20:32 INFO - 'system_bits': '32', 03:20:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:20:32 INFO - 'title': 'talos-linux64-ix-013', 03:20:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:20:32 INFO - 'use_talos_json': True, 03:20:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:20:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:20:32 INFO - 'work_dir': 'build'} 03:20:32 INFO - [mozharness: 2017-08-06 10:20:32.109925Z] Running clobber step. 03:20:32 INFO - Running pre-action listener: _resource_record_pre_action 03:20:32 INFO - Running main action method: clobber 03:20:32 INFO - rmtree: /builds/slave/test/build 03:20:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:20:33 INFO - Running post-action listener: _resource_record_post_action 03:20:33 INFO - [mozharness: 2017-08-06 10:20:33.651217Z] Finished clobber step (success) 03:20:33 INFO - [mozharness: 2017-08-06 10:20:33.651319Z] Running read-buildbot-config step. 03:20:33 INFO - Running pre-action listener: _resource_record_pre_action 03:20:33 INFO - Running main action method: read_buildbot_config 03:20:33 INFO - Using buildbot properties: 03:20:33 INFO - { 03:20:33 INFO - "project": "", 03:20:33 INFO - "product": "firefox", 03:20:33 INFO - "who": "archaeopteryx@coole-files.de", 03:20:33 INFO - "installer_path": "public/build/target.tar.bz2", 03:20:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:20:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:20:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 03:20:33 INFO - "stage_platform": "linux64-pgo", 03:20:33 INFO - "basedir": "/builds/slave/test", 03:20:33 INFO - "buildnumber": 102, 03:20:33 INFO - "platform": "ubuntu64_hw", 03:20:33 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:20:33 INFO - "slavebuilddir": "test", 03:20:33 INFO - "taskId": "bcCNos7XTnmYBKDG6TILjw", 03:20:33 INFO - "branch": "mozilla-central", 03:20:33 INFO - "script_repo_revision": "production", 03:20:33 INFO - "revision": "fe6609d22dfdd710b11e3ac7773aff89f7a8d12c", 03:20:33 INFO - "slavename": "talos-linux64-ix-013", 03:20:33 INFO - "repo_path": "mozilla-central" 03:20:33 INFO - } 03:20:33 INFO - Finding installer, test and symbols from parent task. 03:20:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bcCNos7XTnmYBKDG6TILjw'}, attempt #1 03:20:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bcCNos7XTnmYBKDG6TILjw'}, attempt #1 03:20:34 INFO - Task dependencies: c8lVeiZqRpeG8wBPzFBa7g 03:20:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c8lVeiZqRpeG8wBPzFBa7g'}, attempt #1 03:20:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/c8lVeiZqRpeG8wBPzFBa7g/artifacts/public/build/target.tar.bz2 03:20:35 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/c8lVeiZqRpeG8wBPzFBa7g/artifacts/public/build/target.test_packages.json 03:20:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/c8lVeiZqRpeG8wBPzFBa7g/artifacts/public/build/target.crashreporter-symbols.zip 03:20:35 INFO - Running post-action listener: _resource_record_post_action 03:20:35 INFO - [mozharness: 2017-08-06 10:20:35.016748Z] Finished read-buildbot-config step (success) 03:20:35 INFO - [mozharness: 2017-08-06 10:20:35.016970Z] Running download-and-extract step. 03:20:35 INFO - Running pre-action listener: _resource_record_pre_action 03:20:35 INFO - Running main action method: download_and_extract 03:20:35 INFO - mkdir: /builds/slave/test/build/tests 03:20:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:35 INFO - trying https://queue.taskcluster.net/v1/task/c8lVeiZqRpeG8wBPzFBa7g/artifacts/public/build/target.test_packages.json 03:20:35 INFO - Downloading https://queue.taskcluster.net/v1/task/c8lVeiZqRpeG8wBPzFBa7g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:20:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c8lVeiZqRpeG8wBPzFBa7g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:20:35 INFO - Downloaded 989 bytes. 03:20:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:20:35 INFO - Using the following test package requirements: 03:20:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:20:35 INFO - u'common': [u'target.common.tests.zip'], 03:20:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:20:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:20:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:20:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:20:35 INFO - u'mozbase': [u'target.common.tests.zip'], 03:20:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:20:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:20:35 INFO - u'web-platform': [u'target.common.tests.zip', 03:20:35 INFO - u'target.web-platform.tests.tar.gz'], 03:20:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:20:35 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:20:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c8lVeiZqRpeG8wBPzFBa7g/artifacts/public/build/target.common.tests.zip 03:20:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c8lVeiZqRpeG8wBPzFBa7g/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:20:35 INFO - Fetch https://queue.taskcluster.net/v1/task/c8lVeiZqRpeG8wBPzFBa7g/artifacts/public/build/target.common.tests.zip into memory 03:20:37 INFO - Content-Length response header: 54893586 03:20:37 INFO - Bytes received: 54893586 03:20:48 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:20:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c8lVeiZqRpeG8wBPzFBa7g/artifacts/public/build/target.common.tests.zip 03:20:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c8lVeiZqRpeG8wBPzFBa7g/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:20:48 INFO - Fetch https://queue.taskcluster.net/v1/task/c8lVeiZqRpeG8wBPzFBa7g/artifacts/public/build/target.common.tests.zip into memory 03:20:49 INFO - Content-Length response header: 54893586 03:20:49 INFO - Bytes received: 54893586 03:21:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c8lVeiZqRpeG8wBPzFBa7g/artifacts/public/build/target.talos.tests.zip 03:21:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c8lVeiZqRpeG8wBPzFBa7g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:21:01 INFO - Fetch https://queue.taskcluster.net/v1/task/c8lVeiZqRpeG8wBPzFBa7g/artifacts/public/build/target.talos.tests.zip into memory 03:21:02 INFO - Content-Length response header: 14496008 03:21:02 INFO - Bytes received: 14496008 03:21: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:21:02 INFO - trying https://queue.taskcluster.net/v1/task/c8lVeiZqRpeG8wBPzFBa7g/artifacts/public/build/target.tar.bz2 03:21:02 INFO - Downloading https://queue.taskcluster.net/v1/task/c8lVeiZqRpeG8wBPzFBa7g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:21:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c8lVeiZqRpeG8wBPzFBa7g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:21:04 INFO - Downloaded 62737197 bytes. 03:21:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/c8lVeiZqRpeG8wBPzFBa7g/artifacts/public/build/target.tar.bz2 03:21:04 INFO - mkdir: /builds/slave/test/properties 03:21:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:21:04 INFO - Writing to file /builds/slave/test/properties/build_url 03:21:04 INFO - Contents: 03:21:04 INFO - build_url:https://queue.taskcluster.net/v1/task/c8lVeiZqRpeG8wBPzFBa7g/artifacts/public/build/target.tar.bz2 03:21:04 INFO - Running post-action listener: _resource_record_post_action 03:21:04 INFO - Running post-action listener: set_extra_try_arguments 03:21:04 INFO - [mozharness: 2017-08-06 10:21:04.160615Z] Finished download-and-extract step (success) 03:21:04 INFO - [mozharness: 2017-08-06 10:21:04.160729Z] Running populate-webroot step. 03:21:04 INFO - Running pre-action listener: _resource_record_pre_action 03:21:04 INFO - Running main action method: populate_webroot 03:21:04 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:21:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:21:04 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:21:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:21:04 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:21:04 INFO - 'tests': ['damp', 'tps']}, 03:21:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:21:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:21:04 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:21:04 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:21:04 INFO - 'other-e10s': {'tests': ['a11yr', 03:21:04 INFO - 'ts_paint', 03:21:04 INFO - 'tpaint', 03:21:04 INFO - 'sessionrestore', 03:21:04 INFO - 'sessionrestore_many_windows', 03:21:04 INFO - 'sessionrestore_no_auto_restore', 03:21:04 INFO - 'tabpaint']}, 03:21:04 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:21:04 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:21:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:21:04 INFO - 'tsvgr_opacity', 03:21:04 INFO - 'tart', 03:21:04 INFO - 'tscrollx', 03:21:04 INFO - 'tsvg_static']}, 03:21:04 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:21:04 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:21:04 INFO - 'talos_options': ['--mitmproxy', 03:21:04 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:21:04 INFO - '--firstNonBlankPaint'], 03:21:04 INFO - 'tests': ['tp6_google', 03:21:04 INFO - 'tp6_youtube', 03:21:04 INFO - 'tp6_amazon', 03:21:04 INFO - 'tp6_facebook']}, 03:21:04 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:21:04 INFO - 'talos_options': ['--stylo', 03:21:04 INFO - '--mitmproxy', 03:21:04 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:21:04 INFO - '--firstNonBlankPaint'], 03:21:04 INFO - 'tests': ['tp6_google', 03:21:04 INFO - 'tp6_youtube', 03:21:04 INFO - 'tp6_amazon', 03:21:04 INFO - 'tp6_facebook']}, 03:21:04 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:21:04 INFO - 'talos_options': ['--stylo', 03:21:04 INFO - '--stylo-threads=1', 03:21:04 INFO - '--mitmproxy', 03:21:04 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:21:04 INFO - '--firstNonBlankPaint'], 03:21:04 INFO - 'tests': ['tp6_google', 03:21:04 INFO - 'tp6_youtube', 03:21:04 INFO - 'tp6_amazon', 03:21:04 INFO - 'tp6_facebook']}, 03:21:04 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:21:04 INFO - 'talos_options': ['--xperf_path', 03:21:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:21:04 INFO - 'tests': ['tp5n']}}} 03:21:04 INFO - Running post-action listener: _resource_record_post_action 03:21:04 INFO - [mozharness: 2017-08-06 10:21:04.172277Z] Finished populate-webroot step (success) 03:21:04 INFO - [mozharness: 2017-08-06 10:21:04.172398Z] Running create-virtualenv step. 03:21:04 INFO - Running pre-action listener: _resource_record_pre_action 03:21:04 INFO - Running main action method: create_virtualenv 03:21:04 INFO - Creating virtualenv /builds/slave/test/build/venv 03:21:04 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:21:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:21:04 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:21:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:21:04 INFO - Using real prefix '/usr' 03:21:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:21:04 INFO - Installing distribute.............................................................................................................................................................................................done. 03:21:06 INFO - Installing pip.................done. 03:21:06 INFO - Return code: 0 03:21:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:21:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:21:06 INFO - Reading from file tmpfile_stdout 03:21:06 INFO - Output received: 03:21:06 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:21:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:21:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:06 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 0x20c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2292a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2435d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2432eb0>, '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 0x2433db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2434240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1502014223.252976-1781452603', '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:21:06 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:21:06 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:21:06 INFO - Using env: {'DISPLAY': ':0', 03:21:06 INFO - 'HOME': '/home/cltbld', 03:21:06 INFO - 'LANG': 'en_US.UTF-8', 03:21:06 INFO - 'LANGUAGE': 'en_US:en', 03:21:06 INFO - 'LOGNAME': 'cltbld', 03:21:06 INFO - 'MAIL': '/var/mail/cltbld', 03:21:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:06 INFO - 'MOZ_NO_REMOTE': '1', 03:21:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:06 INFO - 'NO_EM_RESTART': '1', 03:21:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:06 INFO - 'PWD': '/builds/slave/test', 03:21:06 INFO - 'SHELL': '/bin/bash', 03:21:06 INFO - 'SHLVL': '1', 03:21:06 INFO - 'TERM': 'linux', 03:21:06 INFO - 'TMOUT': '86400', 03:21:06 INFO - 'USER': 'cltbld', 03:21:06 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1502014223.252976-1781452603', 03:21:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:06 INFO - '_': '/tools/buildbot/bin/python'} 03:21:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:07 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:21:07 INFO - Cleaning up... 03:21:07 INFO - Return code: 0 03:21:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:21:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:07 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 0x20c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2292a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2435d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2432eb0>, '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 0x2433db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2434240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1502014223.252976-1781452603', '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:21:07 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:21:07 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:21:07 INFO - Using env: {'DISPLAY': ':0', 03:21:07 INFO - 'HOME': '/home/cltbld', 03:21:07 INFO - 'LANG': 'en_US.UTF-8', 03:21:07 INFO - 'LANGUAGE': 'en_US:en', 03:21:07 INFO - 'LOGNAME': 'cltbld', 03:21:07 INFO - 'MAIL': '/var/mail/cltbld', 03:21:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:07 INFO - 'MOZ_NO_REMOTE': '1', 03:21:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:07 INFO - 'NO_EM_RESTART': '1', 03:21:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:07 INFO - 'PWD': '/builds/slave/test', 03:21:07 INFO - 'SHELL': '/bin/bash', 03:21:07 INFO - 'SHLVL': '1', 03:21:07 INFO - 'TERM': 'linux', 03:21:07 INFO - 'TMOUT': '86400', 03:21:07 INFO - 'USER': 'cltbld', 03:21:07 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1502014223.252976-1781452603', 03:21:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:07 INFO - '_': '/tools/buildbot/bin/python'} 03:21:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:07 INFO - Downloading/unpacking psutil>=3.1.1 03:21:07 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:21:07 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:21:07 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:21:07 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:21:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:21:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:21:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:21:09 INFO - Installing collected packages: psutil 03:21:09 INFO - Running setup.py install for psutil 03:21:09 INFO - building 'psutil._psutil_linux' extension 03:21:09 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:21:09 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:21:09 INFO - building 'psutil._psutil_posix' extension 03:21:09 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:21:09 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:21:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:21:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:21:10 INFO - Successfully installed psutil 03:21:10 INFO - Cleaning up... 03:21:10 INFO - Return code: 0 03:21:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:21:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:10 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 0x20c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2292a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2435d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2432eb0>, '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 0x2433db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2434240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1502014223.252976-1781452603', '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:21:10 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:21:10 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:21:10 INFO - Using env: {'DISPLAY': ':0', 03:21:10 INFO - 'HOME': '/home/cltbld', 03:21:10 INFO - 'LANG': 'en_US.UTF-8', 03:21:10 INFO - 'LANGUAGE': 'en_US:en', 03:21:10 INFO - 'LOGNAME': 'cltbld', 03:21:10 INFO - 'MAIL': '/var/mail/cltbld', 03:21:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:10 INFO - 'MOZ_NO_REMOTE': '1', 03:21:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:10 INFO - 'NO_EM_RESTART': '1', 03:21:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:10 INFO - 'PWD': '/builds/slave/test', 03:21:10 INFO - 'SHELL': '/bin/bash', 03:21:10 INFO - 'SHLVL': '1', 03:21:10 INFO - 'TERM': 'linux', 03:21:10 INFO - 'TMOUT': '86400', 03:21:10 INFO - 'USER': 'cltbld', 03:21:10 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1502014223.252976-1781452603', 03:21:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:10 INFO - '_': '/tools/buildbot/bin/python'} 03:21:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:21:10 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:21:10 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:21:10 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:21:10 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:21:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:21:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:21:11 INFO - Installing collected packages: mozsystemmonitor 03:21:11 INFO - Running setup.py install for mozsystemmonitor 03:21:11 INFO - Successfully installed mozsystemmonitor 03:21:11 INFO - Cleaning up... 03:21:11 INFO - Return code: 0 03:21:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:21:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:11 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 0x20c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2292a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2435d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2432eb0>, '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 0x2433db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2434240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1502014223.252976-1781452603', '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:21:11 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:21:11 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:21:11 INFO - Using env: {'DISPLAY': ':0', 03:21:11 INFO - 'HOME': '/home/cltbld', 03:21:11 INFO - 'LANG': 'en_US.UTF-8', 03:21:11 INFO - 'LANGUAGE': 'en_US:en', 03:21:11 INFO - 'LOGNAME': 'cltbld', 03:21:11 INFO - 'MAIL': '/var/mail/cltbld', 03:21:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:11 INFO - 'MOZ_NO_REMOTE': '1', 03:21:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:11 INFO - 'NO_EM_RESTART': '1', 03:21:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:11 INFO - 'PWD': '/builds/slave/test', 03:21:11 INFO - 'SHELL': '/bin/bash', 03:21:11 INFO - 'SHLVL': '1', 03:21:11 INFO - 'TERM': 'linux', 03:21:11 INFO - 'TMOUT': '86400', 03:21:11 INFO - 'USER': 'cltbld', 03:21:11 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1502014223.252976-1781452603', 03:21:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:11 INFO - '_': '/tools/buildbot/bin/python'} 03:21:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:11 INFO - Downloading/unpacking jsonschema==2.5.1 03:21:11 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:21:11 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:21:11 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:21:11 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:21:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:21:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:21:12 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:21:12 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:21:12 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:21:12 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:21:13 INFO - Downloading functools32-3.2.3-2.tar.gz 03:21:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:21:13 INFO - warning: no files found matching '*.txt' 03:21:13 INFO - no previously-included directories found matching 'build' 03:21:13 INFO - no previously-included directories found matching 'dist' 03:21:13 INFO - no previously-included directories found matching '.git*' 03:21:13 INFO - Installing collected packages: jsonschema, functools32 03:21:13 INFO - Running setup.py install for functools32 03:21:13 INFO - warning: no files found matching '*.txt' 03:21:13 INFO - no previously-included directories found matching 'build' 03:21:13 INFO - no previously-included directories found matching 'dist' 03:21:13 INFO - no previously-included directories found matching '.git*' 03:21:13 INFO - Successfully installed jsonschema functools32 03:21:13 INFO - Cleaning up... 03:21:13 INFO - Return code: 0 03:21:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:21:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:13 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 0x20c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2292a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2435d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2432eb0>, '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 0x2433db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2434240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1502014223.252976-1781452603', '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:21:13 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:21:13 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:21:13 INFO - Using env: {'DISPLAY': ':0', 03:21:13 INFO - 'HOME': '/home/cltbld', 03:21:13 INFO - 'LANG': 'en_US.UTF-8', 03:21:13 INFO - 'LANGUAGE': 'en_US:en', 03:21:13 INFO - 'LOGNAME': 'cltbld', 03:21:13 INFO - 'MAIL': '/var/mail/cltbld', 03:21:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:13 INFO - 'MOZ_NO_REMOTE': '1', 03:21:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:13 INFO - 'NO_EM_RESTART': '1', 03:21:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:13 INFO - 'PWD': '/builds/slave/test', 03:21:13 INFO - 'SHELL': '/bin/bash', 03:21:13 INFO - 'SHLVL': '1', 03:21:13 INFO - 'TERM': 'linux', 03:21:13 INFO - 'TMOUT': '86400', 03:21:13 INFO - 'USER': 'cltbld', 03:21:13 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1502014223.252976-1781452603', 03:21:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:13 INFO - '_': '/tools/buildbot/bin/python'} 03:21:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:21:13 INFO - Cleaning up... 03:21:13 INFO - Return code: 0 03:21:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:21:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:13 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 0x20c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2292a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2435d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2432eb0>, '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 0x2433db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2434240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1502014223.252976-1781452603', '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:21:13 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:21:13 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:21:13 INFO - Using env: {'DISPLAY': ':0', 03:21:13 INFO - 'HOME': '/home/cltbld', 03:21:13 INFO - 'LANG': 'en_US.UTF-8', 03:21:13 INFO - 'LANGUAGE': 'en_US:en', 03:21:13 INFO - 'LOGNAME': 'cltbld', 03:21:13 INFO - 'MAIL': '/var/mail/cltbld', 03:21:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:13 INFO - 'MOZ_NO_REMOTE': '1', 03:21:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:13 INFO - 'NO_EM_RESTART': '1', 03:21:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:13 INFO - 'PWD': '/builds/slave/test', 03:21:13 INFO - 'SHELL': '/bin/bash', 03:21:13 INFO - 'SHLVL': '1', 03:21:13 INFO - 'TERM': 'linux', 03:21:13 INFO - 'TMOUT': '86400', 03:21:13 INFO - 'USER': 'cltbld', 03:21:13 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1502014223.252976-1781452603', 03:21:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:13 INFO - '_': '/tools/buildbot/bin/python'} 03:21:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:13 INFO - Downloading/unpacking blobuploader==1.2.4 03:21:13 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:21:13 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:21:13 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:21:13 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:21:14 INFO - Downloading blobuploader-1.2.4.tar.gz 03:21:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:21:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:21:15 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:21:15 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:21:15 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:21:15 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:21:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:21:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:21:15 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:21:15 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:21:15 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:21:15 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:21:15 INFO - Downloading docopt-0.6.1.tar.gz 03:21:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:21:15 INFO - Installing collected packages: blobuploader, requests, docopt 03:21:15 INFO - Running setup.py install for blobuploader 03:21:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:21:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:21:15 INFO - Running setup.py install for requests 03:21:16 INFO - Running setup.py install for docopt 03:21:16 INFO - Successfully installed blobuploader requests docopt 03:21:16 INFO - Cleaning up... 03:21:16 INFO - Return code: 0 03:21:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:16 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 0x20c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2292a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2435d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2432eb0>, '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 0x2433db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2434240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1502014223.252976-1781452603', '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:21:16 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:21:16 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:21:16 INFO - Using env: {'DISPLAY': ':0', 03:21:16 INFO - 'HOME': '/home/cltbld', 03:21:16 INFO - 'LANG': 'en_US.UTF-8', 03:21:16 INFO - 'LANGUAGE': 'en_US:en', 03:21:16 INFO - 'LOGNAME': 'cltbld', 03:21:16 INFO - 'MAIL': '/var/mail/cltbld', 03:21:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:16 INFO - 'MOZ_NO_REMOTE': '1', 03:21:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:16 INFO - 'NO_EM_RESTART': '1', 03:21:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:16 INFO - 'PWD': '/builds/slave/test', 03:21:16 INFO - 'SHELL': '/bin/bash', 03:21:16 INFO - 'SHLVL': '1', 03:21:16 INFO - 'TERM': 'linux', 03:21:16 INFO - 'TMOUT': '86400', 03:21:16 INFO - 'USER': 'cltbld', 03:21:16 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1502014223.252976-1781452603', 03:21:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:16 INFO - '_': '/tools/buildbot/bin/python'} 03:21:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:21:16 INFO - Running setup.py (path:/tmp/pip-IUuBTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:21:16 INFO - Running setup.py (path:/tmp/pip-qnuL_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:21:16 INFO - Running setup.py (path:/tmp/pip-6BAVES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:21:16 INFO - Running setup.py (path:/tmp/pip-vnco9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:21:16 INFO - Running setup.py (path:/tmp/pip-nUi_14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:21:16 INFO - Running setup.py (path:/tmp/pip-hZzt_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:21:16 INFO - Running setup.py (path:/tmp/pip-Ua6598-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:21:16 INFO - Running setup.py (path:/tmp/pip-PGWNQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:21:16 INFO - Running setup.py (path:/tmp/pip-zjVGMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:21:17 INFO - Running setup.py (path:/tmp/pip-tRm0FF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:21:17 INFO - Running setup.py (path:/tmp/pip-mDC5Ve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:21:17 INFO - Running setup.py (path:/tmp/pip-sOTvcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:21:17 INFO - Running setup.py (path:/tmp/pip-V2xRtZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:21:17 INFO - Running setup.py (path:/tmp/pip-faP5jj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:17 INFO - Running setup.py (path:/tmp/pip-HOYwoQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:21:17 INFO - Running setup.py (path:/tmp/pip-2jznNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:21:17 INFO - Running setup.py (path:/tmp/pip-nlj90e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:21:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:21:17 INFO - Running setup.py install for manifestparser 03:21:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:21:17 INFO - Running setup.py install for mozcrash 03:21:17 INFO - Running setup.py install for mozdebug 03:21:17 INFO - Running setup.py install for mozdevice 03:21:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:21:18 INFO - Running setup.py install for mozfile 03:21:18 INFO - Running setup.py install for mozhttpd 03:21:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:21:18 INFO - Running setup.py install for mozinfo 03:21:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:21:18 INFO - Running setup.py install for mozInstall 03:21:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:21:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:21:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:21:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:21:18 INFO - Running setup.py install for mozleak 03:21:18 INFO - Running setup.py install for mozlog 03:21:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:21:18 INFO - Running setup.py install for moznetwork 03:21:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:21:18 INFO - Running setup.py install for mozprocess 03:21:18 INFO - Running setup.py install for mozprofile 03:21:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:21:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:21:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:21:18 INFO - Running setup.py install for mozrunner 03:21:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:21:19 INFO - Running setup.py install for mozscreenshot 03:21:19 INFO - Running setup.py install for moztest 03:21:19 INFO - Running setup.py install for mozversion 03:21:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:21:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:21:19 INFO - Cleaning up... 03:21:19 INFO - Return code: 0 03:21:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:21:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:19 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 0x20c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2292a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2435d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2432eb0>, '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 0x2433db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2434240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1502014223.252976-1781452603', '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:21:19 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:21:19 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:21:19 INFO - Using env: {'DISPLAY': ':0', 03:21:19 INFO - 'HOME': '/home/cltbld', 03:21:19 INFO - 'LANG': 'en_US.UTF-8', 03:21:19 INFO - 'LANGUAGE': 'en_US:en', 03:21:19 INFO - 'LOGNAME': 'cltbld', 03:21:19 INFO - 'MAIL': '/var/mail/cltbld', 03:21:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:19 INFO - 'MOZ_NO_REMOTE': '1', 03:21:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:19 INFO - 'NO_EM_RESTART': '1', 03:21:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:19 INFO - 'PWD': '/builds/slave/test', 03:21:19 INFO - 'SHELL': '/bin/bash', 03:21:19 INFO - 'SHLVL': '1', 03:21:19 INFO - 'TERM': 'linux', 03:21:19 INFO - 'TMOUT': '86400', 03:21:19 INFO - 'USER': 'cltbld', 03:21:19 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1502014223.252976-1781452603', 03:21:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:19 INFO - '_': '/tools/buildbot/bin/python'} 03:21:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:21:19 INFO - Running setup.py (path:/tmp/pip-2ScYDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:21:19 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:21:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:21:19 INFO - Running setup.py (path:/tmp/pip-66i2c1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:21:19 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:21:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:21:19 INFO - Running setup.py (path:/tmp/pip-6Wfy5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:21:19 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:21:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:21:19 INFO - Running setup.py (path:/tmp/pip-HPGABX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:21:19 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:21:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:21:19 INFO - Running setup.py (path:/tmp/pip-_oKvLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:21:19 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:21:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:21:19 INFO - Running setup.py (path:/tmp/pip-4DreJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:21:20 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:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:21:20 INFO - Running setup.py (path:/tmp/pip-fgp5qH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:21:20 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:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:21:20 INFO - Running setup.py (path:/tmp/pip-Zqiz9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:21:20 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:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:21:20 INFO - Running setup.py (path:/tmp/pip-uhHPTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:21:20 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:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:21:20 INFO - Running setup.py (path:/tmp/pip-wpreJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:21:20 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:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:21:20 INFO - Running setup.py (path:/tmp/pip-Wwzynu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:21:20 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:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:21:20 INFO - Running setup.py (path:/tmp/pip-3QPrC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:21:20 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:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:21:20 INFO - Running setup.py (path:/tmp/pip-zCOBg8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:21:20 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:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:21:20 INFO - Running setup.py (path:/tmp/pip-w35t0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:21:20 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:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:20 INFO - Running setup.py (path:/tmp/pip-bnls4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:20 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:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:21:20 INFO - Running setup.py (path:/tmp/pip-IcNNiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:21:20 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:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:21:20 INFO - Running setup.py (path:/tmp/pip-3JDxjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:21:20 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:21:20 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:21:20 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:21:20 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:21:20 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:21:20 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:21:20 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:21:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:21 INFO - Downloading blessings-1.6.tar.gz 03:21:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:21:22 INFO - Installing collected packages: blessings 03:21:22 INFO - Running setup.py install for blessings 03:21:22 INFO - Successfully installed blessings 03:21:22 INFO - Cleaning up... 03:21:22 INFO - Return code: 0 03:21:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:21:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:21:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:21:22 INFO - Reading from file tmpfile_stdout 03:21:22 INFO - Current package versions: 03:21:22 INFO - argparse == 1.2.1 03:21:22 INFO - blessings == 1.6 03:21:22 INFO - blobuploader == 1.2.4 03:21:22 INFO - docopt == 0.6.1 03:21:22 INFO - functools32 == 3.2.3-2 03:21:22 INFO - jsonschema == 2.5.1 03:21:22 INFO - manifestparser == 1.1 03:21:22 INFO - mozInstall == 1.13 03:21:22 INFO - mozcrash == 1.0 03:21:22 INFO - mozdebug == 0.1 03:21:22 INFO - mozdevice == 0.51 03:21:22 INFO - mozfile == 1.2 03:21:22 INFO - mozhttpd == 0.7 03:21:22 INFO - mozinfo == 0.10 03:21:22 INFO - mozleak == 0.1 03:21:22 INFO - mozlog == 3.5 03:21:22 INFO - moznetwork == 0.27 03:21:22 INFO - mozprocess == 0.25 03:21:22 INFO - mozprofile == 0.28 03:21:22 INFO - mozrunner == 6.13 03:21:22 INFO - mozscreenshot == 0.1 03:21:22 INFO - mozsystemmonitor == 0.3 03:21:22 INFO - moztest == 0.8 03:21:22 INFO - mozversion == 1.4 03:21:22 INFO - psutil == 3.1.1 03:21:22 INFO - requests == 1.2.3 03:21:22 INFO - wsgiref == 0.1.2 03:21:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:21:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:22 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 0x20c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2292a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2435d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2432eb0>, '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 0x2433db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2434240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1502014223.252976-1781452603', '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:21:22 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:21:22 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:21:22 INFO - Using env: {'DISPLAY': ':0', 03:21:22 INFO - 'HOME': '/home/cltbld', 03:21:22 INFO - 'LANG': 'en_US.UTF-8', 03:21:22 INFO - 'LANGUAGE': 'en_US:en', 03:21:22 INFO - 'LOGNAME': 'cltbld', 03:21:22 INFO - 'MAIL': '/var/mail/cltbld', 03:21:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:22 INFO - 'MOZ_NO_REMOTE': '1', 03:21:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:22 INFO - 'NO_EM_RESTART': '1', 03:21:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:22 INFO - 'PWD': '/builds/slave/test', 03:21:22 INFO - 'SHELL': '/bin/bash', 03:21:22 INFO - 'SHLVL': '1', 03:21:22 INFO - 'TERM': 'linux', 03:21:22 INFO - 'TMOUT': '86400', 03:21:22 INFO - 'USER': 'cltbld', 03:21:22 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1502014223.252976-1781452603', 03:21:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:22 INFO - '_': '/tools/buildbot/bin/python'} 03:21:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:22 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:21:22 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:21:22 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:21:22 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:21:22 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:21:22 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:21:22 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:21:22 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:21:22 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:21:22 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:21:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:21:23 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:21:23 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:21:23 INFO - Installing collected packages: simplejson 03:21:23 INFO - Running setup.py install for simplejson 03:21:23 INFO - building 'simplejson._speedups' extension 03:21:23 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:21:24 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:21:24 INFO - Successfully installed simplejson 03:21:24 INFO - Cleaning up... 03:21:24 INFO - Return code: 0 03:21:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:21:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2292a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2435d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2432eb0>, '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 0x2433db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2434240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1502014223.252976-1781452603', '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:21:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:21:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:21:24 INFO - Using env: {'DISPLAY': ':0', 03:21:24 INFO - 'HOME': '/home/cltbld', 03:21:24 INFO - 'LANG': 'en_US.UTF-8', 03:21:24 INFO - 'LANGUAGE': 'en_US:en', 03:21:24 INFO - 'LOGNAME': 'cltbld', 03:21:24 INFO - 'MAIL': '/var/mail/cltbld', 03:21:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:24 INFO - 'MOZ_NO_REMOTE': '1', 03:21:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:24 INFO - 'NO_EM_RESTART': '1', 03:21:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:24 INFO - 'PWD': '/builds/slave/test', 03:21:24 INFO - 'SHELL': '/bin/bash', 03:21:24 INFO - 'SHLVL': '1', 03:21:24 INFO - 'TERM': 'linux', 03:21:24 INFO - 'TMOUT': '86400', 03:21:24 INFO - 'USER': 'cltbld', 03:21:24 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1502014223.252976-1781452603', 03:21:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:24 INFO - '_': '/tools/buildbot/bin/python'} 03:21:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:21:25 INFO - Cleaning up... 03:21:25 INFO - Return code: 0 03:21:25 INFO - Running post-action listener: _resource_record_post_action 03:21:25 INFO - Running post-action listener: _start_resource_monitoring 03:21:25 INFO - Starting resource monitoring. 03:21:25 INFO - [mozharness: 2017-08-06 10:21:25.059448Z] Finished create-virtualenv step (success) 03:21:25 INFO - [mozharness: 2017-08-06 10:21:25.059916Z] Running install step. 03:21:25 INFO - Running pre-action listener: _resource_record_pre_action 03:21:25 INFO - Running main action method: install 03:21:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:21:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:21:25 INFO - Reading from file tmpfile_stdout 03:21:25 INFO - Detecting whether we're running mozinstall >=1.0... 03:21:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:21:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:21:25 INFO - Reading from file tmpfile_stdout 03:21:25 INFO - Output received: 03:21:25 INFO - Usage: mozinstall [options] installer 03:21:25 INFO - Options: 03:21:25 INFO - -h, --help show this help message and exit 03:21:25 INFO - -d DEST, --destination=DEST 03:21:25 INFO - Directory to install application into. [default: 03:21:25 INFO - "/builds/slave/test"] 03:21:25 INFO - --app=APP Application being installed. [default: firefox] 03:21:25 INFO - mkdir: /builds/slave/test/build/application 03:21:25 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:21:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:21:43 INFO - Reading from file tmpfile_stdout 03:21:43 INFO - Output received: 03:21:43 INFO - /builds/slave/test/build/application/firefox/firefox 03:21:43 INFO - Running post-action listener: _resource_record_post_action 03:21:43 INFO - [mozharness: 2017-08-06 10:21:43.196873Z] Finished install step (success) 03:21:43 INFO - [mozharness: 2017-08-06 10:21:43.197026Z] Running setup-mitmproxy step. 03:21:43 INFO - Running pre-action listener: _resource_record_pre_action 03:21:43 INFO - Running main action method: setup_mitmproxy 03:21:43 INFO - Skipping: mitmproxy is not required 03:21:43 INFO - Running post-action listener: _resource_record_post_action 03:21:43 INFO - [mozharness: 2017-08-06 10:21:43.197976Z] Finished setup-mitmproxy step (success) 03:21:43 INFO - [mozharness: 2017-08-06 10:21:43.198198Z] Running run-tests step. 03:21:43 INFO - Running pre-action listener: _resource_record_pre_action 03:21:43 INFO - Running pre-action listener: _set_gcov_prefix 03:21:43 INFO - Running main action method: run_tests 03:21:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:21:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:21:43 INFO - Python 2.7.3 03:21:43 INFO - Return code: 0 03:21:43 INFO - grabbing minidump binary from tooltool 03:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:43 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 0x2432eb0>, '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 0x2433db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2434240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:21:43 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:21:43 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:21:43 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:21:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:21:43 INFO - Return code: 0 03:21:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:21:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:21:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:21:43 INFO - ENV: RUST_BACKTRACE is now 1 03:21:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:21:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:21:43 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/c8lVeiZqRpeG8wBPzFBa7g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:21:43 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/c8lVeiZqRpeG8wBPzFBa7g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-013 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:21:43 INFO - Using env: {'DISPLAY': ':0', 03:21:43 INFO - 'HOME': '/home/cltbld', 03:21:43 INFO - 'LANG': 'en_US.UTF-8', 03:21:43 INFO - 'LANGUAGE': 'en_US:en', 03:21:43 INFO - 'LOGNAME': 'cltbld', 03:21:43 INFO - 'MAIL': '/var/mail/cltbld', 03:21:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:21:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:21:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:43 INFO - 'MOZ_NO_REMOTE': '1', 03:21:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:21:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:43 INFO - 'NO_EM_RESTART': '1', 03:21:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:43 INFO - 'PWD': '/builds/slave/test', 03:21:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:21:43 INFO - 'RUST_BACKTRACE': '1', 03:21:43 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:21:43 INFO - 'SHELL': '/bin/bash', 03:21:43 INFO - 'SHLVL': '1', 03:21:43 INFO - 'TERM': 'linux', 03:21:43 INFO - 'TMOUT': '86400', 03:21:43 INFO - 'USER': 'cltbld', 03:21:43 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1502014223.252976-1781452603', 03:21:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:43 INFO - '_': '/tools/buildbot/bin/python'} 03:21:43 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/c8lVeiZqRpeG8wBPzFBa7g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:21:43 INFO - mozversion application_buildid: 20170806090558 03:21:43 INFO - mozversion application_changeset: fe6609d22dfdd710b11e3ac7773aff89f7a8d12c 03:21:43 INFO - mozversion application_display_name: Nightly 03:21:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:21:43 INFO - mozversion application_name: Firefox 03:21:43 INFO - mozversion application_remotingname: firefox 03:21:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:21:43 INFO - mozversion application_vendor: Mozilla 03:21:43 INFO - mozversion application_version: 57.0a1 03:21:43 INFO - mozversion platform_buildid: 20170806090558 03:21:43 INFO - mozversion platform_changeset: fe6609d22dfdd710b11e3ac7773aff89f7a8d12c 03:21:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:21:43 INFO - mozversion platform_version: 57.0a1 03:21:43 INFO - using testdate: 1502014903 03:21:43 INFO - actual date: 1502014903 03:21:43 INFO - starting webserver on 'localhost:55034' 03:21:43 INFO - SUITE-START | Running 2 tests 03:21:43 INFO - TEST-START | dromaeo_css 03:21:43 INFO - Initialising browser for dromaeo_css test... 03:21:43 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55034/getInfo.html -profile /tmp/tmpDac2In/profile 03:21:43 INFO - TEST-INFO | started process 12149 (/builds/slave/test/build/application/firefox/firefox http://localhost:55034/getInfo.html) 03:21:49 INFO - TEST-INFO | 12149: exit 0 03:21:49 INFO - Browser initialized. 03:21:49 INFO - Running cycle 1/1 for dromaeo_css test... 03:21:49 INFO - TEST-INFO | started process 12362 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDac2In/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:21:50 INFO - PID 12362 | 03:21:50 INFO - PID 12362 | (/builds/slave/test/build/application/firefox/firefox:12410): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:21:50 INFO - PID 12362 | 03:22:00 INFO - PID 12362 | RSS: Main: 164524032 03:22:00 INFO - PID 12362 | 03:24:59 INFO - PID 12362 | Cycle 1(1): loaded http://localhost:55034/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55034/tests/dromaeo/cssquery-ext.html) 03:25:00 INFO - PID 12362 | RSS: Main: 166469632 03:25:00 INFO - PID 12362 | 03:28:01 INFO - PID 12362 | Cycle 1(1): loaded http://localhost:55034/tests/dromaeo/cssquery-ext.html (next: http://localhost:55034/tests/dromaeo/cssquery-jquery.html) 03:28:02 INFO - PID 12362 | RSS: Main: 164085760 03:28:02 INFO - PID 12362 | 03:31:03 INFO - PID 12362 | Cycle 1(1): loaded http://localhost:55034/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55034/tests/dromaeo/cssquery-mootools.html) 03:31:04 INFO - PID 12362 | RSS: Main: 166064128 03:31:04 INFO - PID 12362 | 03:34:06 INFO - PID 12362 | Cycle 1(1): loaded http://localhost:55034/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55034/tests/dromaeo/cssquery-prototype.html) 03:34:06 INFO - PID 12362 | RSS: Main: 163442688 03:34:06 INFO - PID 12362 | 03:37:09 INFO - PID 12362 | Cycle 1(1): loaded http://localhost:55034/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55034/tests/dromaeo/cssquery-yui.html) 03:37:10 INFO - PID 12362 | RSS: Main: 167723008 03:37:10 INFO - PID 12362 | 03:40:12 INFO - PID 12362 | Cycle 1(1): loaded http://localhost:55034/tests/dromaeo/cssquery-yui.html (next: http://localhost:55034/tests/dromaeo/cssquery-dojo.html) 03:40:12 INFO - PID 12362 | RSS: Main: 168235008 03:40:12 INFO - PID 12362 | 03:40:12 INFO - PID 12362 | __start_tp_report 03:40:12 INFO - PID 12362 | _x_x_mozilla_page_load 03:40:12 INFO - PID 12362 | _x_x_mozilla_page_load_details 03:40:12 INFO - PID 12362 | |i|pagename|runs| 03:40:12 INFO - PID 12362 | |0;dojo.html;3489.180042689969;3519.1729943463283;3533.1520435095576;3551.9644803551955;3580.2123532822784;6036.818895433133;6159.168512250856;6226.4084911933405;6252.781152659663;6304.054391841226;6131.969340153304;6164.414380633843;6180.690965451732;6197.101420294055;6206.875862482759;5411.972940135293;5424.783008679648;5436.184572314165;5444.91832622511;5522.834314970537;5438.619296649236;5447.809326673567;5466.753996070166;5506.944930550683;5513.255710479074;5331.813386531453;5389.218563308337;5447.346318441792;5537.224788529609;5556.555475561966;5353.625246232766;5411.431799661018;5464.12573988164;5477;5490.945090549123;5420.051490989101;5435.510804027656;5442.074847275933;5442.156465747776;5505.6696598203835;6043.486303664194;6065.878682426327;6114.05232189007;6121.357257487989;6146.446819786241;6623.437007854338;6663.167104111986;6683.331666833278;6684.16447944007;6699.76550820719;6644.235912870034;6649.60102393858;6657.434118099967;6747.291534388916;6756.797296081077;6153.353897840751;6219.47134493564;6221.720022598994;6248.468880145193;6278.121063051222;6825.112735344473;6924.307569243036;6948.444124470131;6950.270221626757;6996.545224560387;6616.139901812733;6619.702113404908;6682.131322927989;6695.866082678416;6700.396964273239;6565.474762019027;6662.467002639777;6748.628825414649;6791.660416979132;6814.352636499525;6602.7028783704845;6603.108580341593;6604.570702904296;6604.768833090819;6653.500987425962;6689.1972963244725;6701.564398314192;6709;6718.294579069225;6724.899126513106;4799.568038876518;4810.013947140827;4854.854354369375;4856.490068542752;4860.246661767432;4210.915781684349;4284.036091879302;4294.377315289265;4296.484421869396;4296.5273819879785;6399.968000159969;6423.96788016057;6483.3516648335735;6483.643399613066;6497.935020649733;6811.318868113248;6842.144731908512;6844.452443804484;6846.075779769767;6852.28051054642;6430.7106180222;6446.129772480749;6460.289368169498;6471.029345598198;6517.739290428424;5353.9732301338245;5408.567314614821;5418.051840927822;5472.370677372073;5474.987127381447;7169.318914703095;7237.457190710717;7257.92742072583;7265.745698900513;7269.491135620456;6694.799156025327;6777.525573210025;6833.93166068333;6854.040434339297;6858.0398744176855;7008.579485230903;7117.75087871922;7179.353858152791;7263.927360726325;7273.527220730635;6607.57050791697;6675.198976122896;6715.899261511179;6720.8319792005595;6732.899006514808;6801.795946121624;6847.144106986627;6853.4859885507785;6856.108705868205;6859.314068593101;6574.506911981525;6577.6053436793945;6581.14445122131;6664.633445160563;6664.900026499509;6552.63960482159;6588.967055164693;6600.471962243105;6639.834004149935;6643.30245324234;6539.411452969255;6596.70314835824;6599.406053455212;6621.569597976116;6632.602043877383;6497.057926600711;6584.341565843377;6602.339766023551;6643.103181070687;6671.633060181736;6387.489000880011;6390.201224846895;6423.775167869102;6437.774677886251;6465.159529261354 03:40:12 INFO - PID 12362 | |1;ext.html;907.1472815553379;940.163254703314;966.6568368229279;1184.7275126720854;1205.5840734946441;32732.509012364833;42386.15227695448;42794;43103.137937241234;43121.13757724844;42921.356179657254;43050.35424468636;43145;43217.7839110804;43276.78361608188;7377.63111844407;7520.623968801566;7521.548707077593;7526.021617189757;7533.35966442853;7397.075365579302;7449.329560339568;7492.138404083518;7502.212267711866;7512.136104348016;7513.098428188625;7549.207333230014;7555.16893141754;7561.584112873789;7565.470417070807;7517.473776835596;7540.962295188544;7541.698332066738;7543.132539757943;7544.358729507999;7404.4816862819625;7442.553446793209;7464.514806537558;7468.365188958945;7469.253074692541;39645.60354396448;39670.603293967266;39674.60325396767;39877.80061099676;39993;3388.8305584720665;3464.4803279508023;3464.5149679044953;3469.8959031229106;3472.3402553515;32210;32230;32230.516542251884;32310.838445807854;32350.676493235238;4940;5084.059449001947;5099.59203263738;5124.743762811844;5137.434882162959;209062;209545;209962;209987;210566;50303.49696502988;50348.748256258485;50497.49502505001;50660.240096398586;50721;53088.73455632697;53284.200736988976;53312.20031699527;53480.46519534755;53498.197527037126;15104.54686359411;15402.691946161014;16467.423640172536;16493.835061649468;16593;13321.067525273138;13356.464006639166;13365.732685346238;13383.598492045254;13458.730825383438;14766.523347665363;14883.776743348859;14972.775408368883;14976.850231497545;15003.624909377135;5814.273215848019;5856.912146317809;5908.261467316585;5929.165543340392;5949.702514874239;1076.2573824061528;1100.7138144082596;1110.8555887734542;1117.3351855645878;1117.776444711061;24401.633975490382;24942.5011499769;25005.374865628506;25244.49511009806;25282;1185.5080141741253;1190.2858285028913;1195.988040119605;1203.668991027457;1222.1872454817624;13284.667883302995;13385.732285354434;13395.464181432828;13431.12697674648;13665.795013074812;280594;284964;285874;286159;286752;54201.18698219451;54380.45619543754;54507;54607.18089228665;54610.45389546054;1481.7925490431348;1516.9772453413207;1525.4203402707121;1536.9538913832603;1545.8145022597134;22878.771212287666;23184.18855340055;23205.651915220948;23382.76617233806;23704.762952370256;38814.80592597019;38941.80529097337;38951;39088.21823563456;39225.411618826314;216952;217761;233273;240806;241619;35816.4627530582;36188.63811361958;38720.22559548737;39768;39973.800131000324;49021;49082;49605;49927.75180620514;49937;36076;36603.26793464062;36637.63362366342;36897.63102368942;37093;36406.661873950914;36444.088897777765;36526;36731.44902826406;36982.63017369792;42135.36796947987;42553.57446425496;42580.574194257664;42639.360409594505;42804.57195428006;31926.840365798023;32214.516782247818;32573.34853302968;32864.835675821465;32892.671073289916;26478;27075.59386609163;27166.1850144496;27292;27472.862635687492 03:40:12 INFO - PID 12362 | |2;jquery.html;574.2468569621255;585.7539833270024;586.7213073789949;592.4016743089478;596.6748122273362;21764.782352176473;22750.203742869002;22762.089516419324;22782.88608556957;23275.767242327613;26978.325541861464;27430.17709468714;27542.17373478794;27552;27586.17241482754;6077.0884367344925;6181.196444462236;6187.164732761087;6187.628742275456;6236.345183755709;5922.703864806764;6128.264608247016;6189.938100619003;6231.22109736283;6234.314225435199;6166.167567378414;6194;6194.442500175006;6195.194624698783;6196.473299769525;6141.416565426277;6159.784407545737;6208.96895515524;6213.813585592439;6214.8135555933395;5769.653820770767;5802.187693722883;5805.10020946754;5808.215890854723;5808.88382232353;30304.69695303041;30522.694773052208;31133;31471.37057258842;31759;2212.933611991643;2239.798418142375;2241.6301310283784;2246.8651880887037;2251.718535183102;19797.208111675514;20430.284940027028;20451.89774051135;20482.18071277147;20492.282770102975;2387.2957477544164;2450.8161887858305;2458.1027924807495;2527.545041892459;2536.8351057181226;149065;152530.23734881254;153320;157084;161030;14842.257887105601;15484.690306193814;15780.605484862741;15863;16189.190540473164;24373.14693985702;24450.510989780105;24492.38769030753;24514.754852451246;24520.264392068268;10364.948175259075;10397.792044159074;10492.370457772558;10524.684259472227;10727.463626818628;8106.9594652027545;9599.664011759554;9681.419114853132;9700.223982081558;9849.21206303494;8660.17728315809;9607.711768646952;9671.17794987434;9768.316217864682;9857.901420985841;2862.7852911031755;2893.551499517578;2901.231173738961;2927.751141152983;2976.6130403047464;1042.47876061969;1053.8103141434615;1062.8193207154802;1062.9202809789142;1065.6536625596557;21357.78642213589;21681.699098054167;21726.674099888514;21772.12911483523;21901.561968760536;1119.8488204092507;1119.9440027998567;1129.8418221449003;1130.0676941523277;1132.1565433751907;11604.187706860439;11935.820962685566;11990.400479975966;12023.158378913393;12066.758664826655;581027;594002;595177;601538;607154;131953.34023329822;140332.29833850765;140687;141119;142851.2857435727;1322.6032190342858;1326.7479178955969;1362.0533729058407;1368.4799776085024;1370.1778932640336;21022.579548409252;21107.788922110583;21178.364649060553;21559.892200538896;21594;65042.07310671126;65351.673241633485;65392.346076538626;65889.34110659023;66675;81543;82147.12485062995;82378.58810705908;82642.17357826585;85355.14644853472;15378.846211538188;15857.207139643202;15931.725461963248;15999.440019599258;16037.67924641524;24832.50334993326;25122.874385627954;25310.746892531577;25407;25807.354816129748;20490.897545512176;20586.27948021812;20682.276120335715;20720.378388648365;20919.26782562603;17367.30530778755;17659.20533576018;17960.191791369158;18358.173882175066;18359.632807344045;20682;20696.17215311371;20761.273355432488;21122.788772112082;21133.89433052825;15470.381184752934;15567.377304907677;15570.84429155694;15703.136327502098;15752.606184845012;20062.197512099352;20431.284905028253;20972.895135524224;21014.369568912956;21059.473513162295 03:40:12 INFO - PID 12362 | |3;mootools.html;1421.4527406948328;1421.6090575091848;1439.7984282200487;1457.9927100364496;1510.297711564123;14791.926040369797;15346.155961422117;15370.07779533226;15370.462033828804;15863.3654653814;15828.366865325403;16113.033218006898;16117.194140292997;16127.43553975611;16134;2714.796390270728;2795.0636536760157;2824.15275417375;2827.4345130973784;2832.6034355190186;2795.7204279572084;2824.0398264590035;2833.249188964926;2834.248924035122;2836.177508522526;2671.7728993035516;2737.794665400093;2781.1934538983774;2783.846888421136;2785.6517935258094;2549.413634863982;2585.4829034193235;2592.779613732835;2596.4547445036565;2645.695744989322;2682.9865850670817;2695.9326016849736;2713.3352328679402;2714.253580265443;2716.090109813215;15198.544043678707;15296;15503.612409689735;15521.611959700986;15542.766858497018;8245.422820402575;8517.148285171495;8533.701320453754;8545.230929216339;8556.101609331055;5479.698616576086;5762.481376676119;5844.649321040709;5846.7076646167525;5867.061270196748;1897.5920177161977;1959.5688948431323;1967.9606407871763;1996.061850930075;1998.2306811877386;25319.367015824566;25781.61327580088;25847;26743.06399276016;26995.595066074024;7005.0893383859775;7008.964955175192;7059.858802823915;7124.323189297009;7204.135503739585;17896.55258618545;18258;18269.908650456928;18423.53941151482;18470.630587388445;7980;8125.796855078552;8140.959295203605;8153.633086511121;8191.590420478952;7484.288992545699;7580.848383032308;7615.961920190474;7807.921920780833;7864.5281283123195;5235.345581802275;5367.4364191759305;5390.622656414013;5410.431904650034;5449.264349312792;1542.6837498312818;1562.3594326326152;1569.739575011979;1577.3296349051607;1589.570815879706;932.2681694869494;965.2471072563412;972.6936015155203;973.4743238651049;978.3200675530438;8037.115917249098;8047.315978141924;8068.1528439513;8109.553974531457;8133;763.7785042337771;776.1074764021421;778.5873487051872;782.5969625642798;785.0461689047835;4894.877628059327;4925.335079764186;4960.181570040902;5265.420803711589;5723.313202415737;21958.23146189876;22652.773472265068;22799.202027929274;22812.2015729452;22835.771642283366;21486.355409337746;21756.78243217579;21835;22203.66694499584;22306.888465557568;11791.941040294916;11968.461419236155;12320.938395308145;12330.260184388966;12372.690682733004;8763.474191548272;9085.500297483703;9271.953640231755;9273.072692730673;9291;18984.240630374632;19300.90349548243;19301.90349048246;19639.41081767492;19871.801281986995;19447.222111115396;19719.40841774749;19868.60262794707;20187.293444729363;20386.898065509577;12818.935905320786;13121.212727236396;13128.409221584861;13144;13170.934145329213;14257.714845703234;14540.49108281205;14618.122912625277;14687.045342052732;14690;11680.415979201176;11686.474108664961;12022.63932082039;12056.336901470504;12166.270023798601;11320.547178113113;11345.659630211107;11571.074314055024;11700.590479333183;11744.530218791153;9939.403635781588;10014.098731114234;10110.69667909964;10126.79746405053;10128.898711012796;7177.928220717726;7212.74755383559;7237.782866513802;7245.746398876014;7252;7622.961885190539;7627.351675107456;7653.387728981779;7717.845643086995;7836.804079898048 03:40:12 INFO - PID 12362 | |4;prototype.html;518.4012465602231;529.5922139952238;544.1647071744871;548.5940404100965;550.1005855426376;6076.726547305371;6154.199839073222;6192.78325258616;6214.508517955692;6218.502519798422;6067.605605635642;6098.17674613927;6123.663198524079;6127.816165515042;6150.66171360575;4757.381540399743;4792.137415265251;4848.442429120643;4893.14369985253;4950.579200767939;4834.830780922668;4851.587615052707;4852.4662287148385;4854;4875.585575226092;4813.109574728669;4825.855224343258;4839.903201935959;4856.223004319309;4858.319835223072;4857.3685420895235;4860.8055677772845;4873.805917550188;4879.268109783526;4883.26750987353;4345.67407444443;4385.8245670173155;4409.426774519324;4414.977925110354;4429.933550996738;6006.579539432241;6021.909671354933;6022.6687532185715;6026.548008899306;6036.245469316335;5753.597248192628;5775.509081728016;5790.247267855194;5800.20193739942;5801.245838041028;6473.902891456632;6546.541742078057;6591.340865913418;6620.23867255267;6647.368499992493;4848.733319667417;4869.464358920552;4926.704397736147;4938.185199442088;4985.725785081819;6539.215294164683;6671.4662826973245;6770.356816102462;6838.316168383171;6949.583025018515;4982.526659967298;5003.199488081889;5064.366954130734;5078.21287700407;5079.822206222764;5128.282040514331;5130.30740849988;5153.149730294459;5165.715885626327;5174.301469301596;5663.858403539862;5674.319081710139;5720.256366672389;5735.082386818172;5750.223719797774;6546.967265163644;6564.212294524687;6588.275289718127;6597.505187110986;6601.481659218407;1772.5745821002865;1774.3434929076325;1793.390247315919;1794.425783749214;1799.8380145786941;1193.7791508570942;1254.1033161289722;1267.3853181207107;1271.2563150557028;1279.1365828066018;6356.8410789729705;6358.650274234869;6363.840903977438;6389.361063893573;6405.743770249138;6649.601023938482;6661.766838160641;6691.929291313367;6696.7656132035145;6743.865122697519;6232.407921247474;6336.841578960563;6371.279754466268;6374.266959299647;6375.808725738235;3469.965300347015;3492.956620377057;3507.8421471033867;3516.7867085855337;3537.646235376442;7071.398931090812;7106.395956343768;7123.679434425463;7137.785866424016;7179.748708795167;6443.775682620287;6810.965945170342;6829.863402732017;6851.3491218334175;6861.794146175623;6976.302369762983;7034.824129396704;7081.92918070823;7098.68055937484;7183.640817959185;6696.464282857457;6703.631300278532;6721.327867213239;6740.831479213059;6754.628495432798;6523.412892839668;6526.347365263436;6584.4732421405215;6588.571742836701;6627.3372662733345;7011.228764835762;7019.403350715246;7026.859462810613;7061.71753129869;7200.423966082805;5101.46434624374;5116.411612664591;5118.820841270538;5141.871453213699;5157.149070403341;6444.806655800334;6461.386168314003;6539.934600653933;6688.966555167388;6696.363845434676;6386.521010924293;6412;6456.677166141768;6465.3857883501;6500.122483464672;6400.743970241138;6436.485081193587;6485.286618472059;6507.550997971083;6529.84515110022;6377.023122831937;6378.819918315126;6390.265119511316;6532.608043517404;6542.509311801729;6460.903086453613;6508.349165083454;6514.804555863332;6562.228198386313;6563.671816409065;6309.621422714652;6329.936700633119;6365.427111559982;6374.74501019954;6431.871362572816 03:40:12 INFO - PID 12362 | |5;yui.html;904.4166512599373;916.0335845682811;942.7784470649397;944.7732544189397;960.7790208252104;17637.29450821967;18345.54136146597;18349.26602935881;18360.265589376424;20230.190792368325;21755.564888702218;22358.21746238882;22444.32667019988;22491.887540562315;22571.887140564275;1009.924255680825;1040.2770074798018;1044.843273508972;1047.732828128826;1049.6588608702164;1008.6699723638419;1047.9109275711573;1051.805415998043;1056.5034433816095;1056.873175218975;1105.3423213188141;1109.517359948425;1112.6606385052555;1113.120634698587;1115.0912006714502;1090.9236353455262;1095.9287646303005;1097.5884043483693;1100.7908497385472;1102.4267380961935;804.0311424733183;804.9275565199101;805.2390490986021;805.8589746794346;806.7418426103649;19836.504087397785;20046.498837529034;20093.296734614363;20096.497587560283;20875.478113047142;21064.473388165265;21676.458088547755;22003;22022.449438764;22057.22799702019;16930.915345423316;17012.319507219698;17017.744733829004;17168.656626867392;17226.56933576658;3730.925381492355;3765.8870233893026;3771.15149091455;3774.1508160663907;3774.9811250943844;142291;145764.2711786445;147351.26324368417;147773;150353;17268;17378.65242695139;17546.847533252527;17587.384441544484;17659.73510397345;32856.50715239273;33269;33373.66626333754;33615.83192084024;33660.66339336575;8849.557522123869;8934.463932164092;8970.192682658591;8973.37186396946;9013.098690130935;4139.668826493873;4247.086876321606;4253.829846806093;4257.8509752158525;4271.957280427218;5496.422875598085;6000.969995149996;6247.625142491465;6249.125122482856;6262.718177682015;1153.7251337272362;1172.1033409441784;1199.7744184537733;1206.7827790997706;1210.3887536794039;734.4051318432087;744.5160645580416;749.9400047996256;752.6876346316327;766.731643924622;13073.607791766262;13650.522231721841;13763;14221.573352799225;14419.134851908919;727.4544091931052;728.9817754556178;731.7841236835146;735.3235023778137;744.7467860927202;6319.778807741799;6450.741970321134;6466.967665161644;6473.741050358027;6554.63949482783;124166.37916810358;124344;125666.37166814107;126077;126510;109178.45410772895;109477;112303;112669.4366528162;115052.42473787577;93540.53229733808;96874.03125968791;97640.51179744056;98391;99307;13649.38577763983;13732.244726539737;13869.722605547631;14311.57065288043;14526.709465810836;43839.78080109579;46761.83095422642;47245;47929.52070479251;49471.50528494669;58490;58557.70721146537;58974.410255896895;59817.700911495165;61924.59414732233;19617;19721.40835774929;19866.50333741668;20058.799412005694;20093.39719808408;22480.775192247867;22749;22785.20251791179;22885;22959.6556051656;20508.282210122576;20518.794812052285;20643.793562064788;20649.380518584465;20757.377278681663;19938.501537461678;19973.300934467225;20184.596308073462;20458.69311960292;21061.57876842424;20990.580188396452;21248.681269780656;21295.148194072062;21297.254596089064;21448.356549303546;13408.932955335162;13997.860021399656;14090.929545352208;14676;15065.698686025999;15903.284352203947;16034.919825401264;16080.678386431971;16771.832281677027;16892.746608801124 03:40:12 INFO - PID 12362 | __end_tp_report 03:40:12 INFO - PID 12362 | __start_cc_report 03:40:12 INFO - PID 12362 | _x_x_mozilla_cycle_collect,331 03:40:12 INFO - PID 12362 | __end_cc_report 03:40:12 INFO - PID 12362 | __startTimestamp1502016012268__endTimestamp 03:40:12 INFO - PID 12362 | 03:40:12 INFO - PID 12362 | ------- Summary: start ------- 03:40:12 INFO - PID 12362 | Number of tests: 6 03:40:12 INFO - PID 12362 | 03:40:12 INFO - PID 12362 | [#0] dojo.html Cycles:165 Average:6192.98 Median:6552.64 stddev:825.13 (12.6%) stddev-sans-first:799.93 03:40:12 INFO - PID 12362 | Values: 3489.2 3519.2 3533.2 3552.0 3580.2 6036.8 6159.2 6226.4 6252.8 6304.1 6132.0 6164.4 6180.7 6197.1 6206.9 5412.0 5424.8 5436.2 5444.9 5522.8 5438.6 5447.8 5466.8 5506.9 5513.3 5331.8 5389.2 5447.3 5537.2 5556.6 5353.6 5411.4 5464.1 5477.0 5490.9 5420.1 5435.5 5442.1 5442.2 5505.7 6043.5 6065.9 6114.1 6121.4 6146.4 6623.4 6663.2 6683.3 6684.2 6699.8 6644.2 6649.6 6657.4 6747.3 6756.8 6153.4 6219.5 6221.7 6248.5 6278.1 6825.1 6924.3 6948.4 6950.3 6996.5 6616.1 6619.7 6682.1 6695.9 6700.4 6565.5 6662.5 6748.6 6791.7 6814.4 6602.7 6603.1 6604.6 6604.8 6653.5 6689.2 6701.6 6709.0 6718.3 6724.9 4799.6 4810.0 4854.9 4856.5 4860.2 4210.9 4284.0 4294.4 4296.5 4296.5 6400.0 6424.0 6483.4 6483.6 6497.9 6811.3 6842.1 6844.5 6846.1 6852.3 6430.7 6446.1 6460.3 6471.0 6517.7 5354.0 5408.6 5418.1 5472.4 5475.0 7169.3 7237.5 7257.9 7265.7 7269.5 6694.8 6777.5 6833.9 6854.0 6858.0 7008.6 7117.8 7179.4 7263.9 7273.5 6607.6 6675.2 6715.9 6720.8 6732.9 6801.8 6847.1 6853.5 6856.1 6859.3 6574.5 6577.6 6581.1 6664.6 6664.9 6552.6 6589.0 6600.5 6639.8 6643.3 6539.4 6596.7 6599.4 6621.6 6632.6 6497.1 6584.3 6602.3 6643.1 6671.6 6387.5 6390.2 6423.8 6437.8 6465.2 03:40:12 INFO - PID 12362 | 03:40:12 INFO - PID 12362 | [#1] ext.html Cycles:180 Average:41774.13 Median:36684.54 stddev:63425.76 (172.9%) stddev-sans-first:63529.46 03:40:12 INFO - PID 12362 | Values: 907.1 940.2 966.7 1184.7 1205.6 32732.5 42386.2 42794.0 43103.1 43121.1 42921.4 43050.4 43145.0 43217.8 43276.8 7377.6 7520.6 7521.5 7526.0 7533.4 7397.1 7449.3 7492.1 7502.2 7512.1 7513.1 7549.2 7555.2 7561.6 7565.5 7517.5 7541.0 7541.7 7543.1 7544.4 7404.5 7442.6 7464.5 7468.4 7469.3 39645.6 39670.6 39674.6 39877.8 39993.0 3388.8 3464.5 3464.5 3469.9 3472.3 32210.0 32230.0 32230.5 32310.8 32350.7 4940.0 5084.1 5099.6 5124.7 5137.4 209062.0 209545.0 209962.0 209987.0 210566.0 50303.5 50348.7 50497.5 50660.2 50721.0 53088.7 53284.2 53312.2 53480.5 53498.2 15104.5 15402.7 16467.4 16493.8 16593.0 13321.1 13356.5 13365.7 13383.6 13458.7 14766.5 14883.8 14972.8 14976.9 15003.6 5814.3 5856.9 5908.3 5929.2 5949.7 1076.3 1100.7 1110.9 1117.3 1117.8 24401.6 24942.5 25005.4 25244.5 25282.0 1185.5 1190.3 1196.0 1203.7 1222.2 13284.7 13385.7 13395.5 13431.1 13665.8 280594.0 284964.0 285874.0 286159.0 286752.0 54201.2 54380.5 54507.0 54607.2 54610.5 1481.8 1517.0 1525.4 1537.0 1545.8 22878.8 23184.2 23205.7 23382.8 23704.8 38814.8 38941.8 38951.0 39088.2 39225.4 216952.0 217761.0 233273.0 240806.0 241619.0 35816.5 36188.6 38720.2 39768.0 39973.8 49021.0 49082.0 49605.0 49927.8 49937.0 36076.0 36603.3 36637.6 36897.6 37093.0 36406.7 36444.1 36526.0 36731.4 36982.6 42135.4 42553.6 42580.6 42639.4 42804.6 31926.8 32214.5 32573.3 32864.8 32892.7 26478.0 27075.6 27166.2 27292.0 27472.9 03:40:12 INFO - PID 12362 | 03:40:12 INFO - PID 12362 | [#2] jquery.html Cycles:180 Average:40092.03 Median:12500.96 stddev:100209.61 (801.6%) stddev-sans-first:100446.80 03:40:12 INFO - PID 12362 | Values: 574.2 585.8 586.7 592.4 596.7 21764.8 22750.2 22762.1 22782.9 23275.8 26978.3 27430.2 27542.2 27552.0 27586.2 6077.1 6181.2 6187.2 6187.6 6236.3 5922.7 6128.3 6189.9 6231.2 6234.3 6166.2 6194.0 6194.4 6195.2 6196.5 6141.4 6159.8 6209.0 6213.8 6214.8 5769.7 5802.2 5805.1 5808.2 5808.9 30304.7 30522.7 31133.0 31471.4 31759.0 2212.9 2239.8 2241.6 2246.9 2251.7 19797.2 20430.3 20451.9 20482.2 20492.3 2387.3 2450.8 2458.1 2527.5 2536.8 149065.0 152530.2 153320.0 157084.0 161030.0 14842.3 15484.7 15780.6 15863.0 16189.2 24373.1 24450.5 24492.4 24514.8 24520.3 10364.9 10397.8 10492.4 10524.7 10727.5 8107.0 9599.7 9681.4 9700.2 9849.2 8660.2 9607.7 9671.2 9768.3 9857.9 2862.8 2893.6 2901.2 2927.8 2976.6 1042.5 1053.8 1062.8 1062.9 1065.7 21357.8 21681.7 21726.7 21772.1 21901.6 1119.8 1119.9 1129.8 1130.1 1132.2 11604.2 11935.8 11990.4 12023.2 12066.8 581027.0 594002.0 595177.0 601538.0 607154.0 131953.3 140332.3 140687.0 141119.0 142851.3 1322.6 1326.7 1362.1 1368.5 1370.2 21022.6 21107.8 21178.4 21559.9 21594.0 65042.1 65351.7 65392.3 65889.3 66675.0 81543.0 82147.1 82378.6 82642.2 85355.1 15378.8 15857.2 15931.7 15999.4 16037.7 24832.5 25122.9 25310.7 25407.0 25807.4 20490.9 20586.3 20682.3 20720.4 20919.3 17367.3 17659.2 17960.2 18358.2 18359.6 20682.0 20696.2 20761.3 21122.8 21133.9 15470.4 15567.4 15570.8 15703.1 15752.6 20062.2 20431.3 20972.9 21014.4 21059.5 03:40:12 INFO - PID 12362 | 03:40:12 INFO - PID 12362 | [#3] mootools.html Cycles:180 Average:9682.69 Median:2621.08 stddev:6870.60 (262.1%) stddev-sans-first:6861.83 03:40:12 INFO - PID 12362 | Values: 1421.5 1421.6 1439.8 1458.0 1510.3 14791.9 15346.2 15370.1 15370.5 15863.4 15828.4 16113.0 16117.2 16127.4 16134.0 2714.8 2795.1 2824.2 2827.4 2832.6 2795.7 2824.0 2833.2 2834.2 2836.2 2671.8 2737.8 2781.2 2783.8 2785.7 2549.4 2585.5 2592.8 2596.5 2645.7 2683.0 2695.9 2713.3 2714.3 2716.1 15198.5 15296.0 15503.6 15521.6 15542.8 8245.4 8517.1 8533.7 8545.2 8556.1 5479.7 5762.5 5844.6 5846.7 5867.1 1897.6 1959.6 1968.0 1996.1 1998.2 25319.4 25781.6 25847.0 26743.1 26995.6 7005.1 7009.0 7059.9 7124.3 7204.1 17896.6 18258.0 18269.9 18423.5 18470.6 7980.0 8125.8 8141.0 8153.6 8191.6 7484.3 7580.8 7616.0 7807.9 7864.5 5235.3 5367.4 5390.6 5410.4 5449.3 1542.7 1562.4 1569.7 1577.3 1589.6 932.3 965.2 972.7 973.5 978.3 8037.1 8047.3 8068.2 8109.6 8133.0 763.8 776.1 778.6 782.6 785.0 4894.9 4925.3 4960.2 5265.4 5723.3 21958.2 22652.8 22799.2 22812.2 22835.8 21486.4 21756.8 21835.0 22203.7 22306.9 11791.9 11968.5 12320.9 12330.3 12372.7 8763.5 9085.5 9272.0 9273.1 9291.0 18984.2 19300.9 19301.9 19639.4 19871.8 19447.2 19719.4 19868.6 20187.3 20386.9 12818.9 13121.2 13128.4 13144.0 13170.9 14257.7 14540.5 14618.1 14687.0 14690.0 11680.4 11686.5 12022.6 12056.3 12166.3 11320.5 11345.7 11571.1 11700.6 11744.5 9939.4 10014.1 10110.7 10126.8 10128.9 7177.9 7212.7 7237.8 7245.7 7252.0 7623.0 7627.4 7653.4 7717.8 7836.8 03:40:12 INFO - PID 12362 | 03:40:12 INFO - PID 12362 | [#4] prototype.html Cycles:180 Average:5565.65 Median:6271.01 stddev:1581.39 (25.2%) stddev-sans-first:1539.78 03:40:12 INFO - PID 12362 | Values: 518.4 529.6 544.2 548.6 550.1 6076.7 6154.2 6192.8 6214.5 6218.5 6067.6 6098.2 6123.7 6127.8 6150.7 4757.4 4792.1 4848.4 4893.1 4950.6 4834.8 4851.6 4852.5 4854.0 4875.6 4813.1 4825.9 4839.9 4856.2 4858.3 4857.4 4860.8 4873.8 4879.3 4883.3 4345.7 4385.8 4409.4 4415.0 4429.9 6006.6 6021.9 6022.7 6026.5 6036.2 5753.6 5775.5 5790.2 5800.2 5801.2 6473.9 6546.5 6591.3 6620.2 6647.4 4848.7 4869.5 4926.7 4938.2 4985.7 6539.2 6671.5 6770.4 6838.3 6949.6 4982.5 5003.2 5064.4 5078.2 5079.8 5128.3 5130.3 5153.1 5165.7 5174.3 5663.9 5674.3 5720.3 5735.1 5750.2 6547.0 6564.2 6588.3 6597.5 6601.5 1772.6 1774.3 1793.4 1794.4 1799.8 1193.8 1254.1 1267.4 1271.3 1279.1 6356.8 6358.7 6363.8 6389.4 6405.7 6649.6 6661.8 6691.9 6696.8 6743.9 6232.4 6336.8 6371.3 6374.3 6375.8 3470.0 3493.0 3507.8 3516.8 3537.6 7071.4 7106.4 7123.7 7137.8 7179.7 6443.8 6811.0 6829.9 6851.3 6861.8 6976.3 7034.8 7081.9 7098.7 7183.6 6696.5 6703.6 6721.3 6740.8 6754.6 6523.4 6526.3 6584.5 6588.6 6627.3 7011.2 7019.4 7026.9 7061.7 7200.4 5101.5 5116.4 5118.8 5141.9 5157.1 6444.8 6461.4 6539.9 6689.0 6696.4 6386.5 6412.0 6456.7 6465.4 6500.1 6400.7 6436.5 6485.3 6507.6 6529.8 6377.0 6378.8 6390.3 6532.6 6542.5 6460.9 6508.3 6514.8 6562.2 6563.7 6309.6 6329.9 6365.4 6374.7 6431.9 03:40:12 INFO - PID 12362 | 03:40:12 INFO - PID 12362 | [#5] yui.html Cycles:180 Average:26104.03 Median:20646.59 stddev:36274.57 (175.7%) stddev-sans-first:36326.98 03:40:12 INFO - PID 12362 | Values: 904.4 916.0 942.8 944.8 960.8 17637.3 18345.5 18349.3 18360.3 20230.2 21755.6 22358.2 22444.3 22491.9 22571.9 1009.9 1040.3 1044.8 1047.7 1049.7 1008.7 1047.9 1051.8 1056.5 1056.9 1105.3 1109.5 1112.7 1113.1 1115.1 1090.9 1095.9 1097.6 1100.8 1102.4 804.0 804.9 805.2 805.9 806.7 19836.5 20046.5 20093.3 20096.5 20875.5 21064.5 21676.5 22003.0 22022.4 22057.2 16930.9 17012.3 17017.7 17168.7 17226.6 3730.9 3765.9 3771.2 3774.2 3775.0 142291.0 145764.3 147351.3 147773.0 150353.0 17268.0 17378.7 17546.8 17587.4 17659.7 32856.5 33269.0 33373.7 33615.8 33660.7 8849.6 8934.5 8970.2 8973.4 9013.1 4139.7 4247.1 4253.8 4257.9 4272.0 5496.4 6001.0 6247.6 6249.1 6262.7 1153.7 1172.1 1199.8 1206.8 1210.4 734.4 744.5 749.9 752.7 766.7 13073.6 13650.5 13763.0 14221.6 14419.1 727.5 729.0 731.8 735.3 744.7 6319.8 6450.7 6467.0 6473.7 6554.6 124166.4 124344.0 125666.4 126077.0 126510.0 109178.5 109477.0 112303.0 112669.4 115052.4 93540.5 96874.0 97640.5 98391.0 99307.0 13649.4 13732.2 13869.7 14311.6 14526.7 43839.8 46761.8 47245.0 47929.5 49471.5 58490.0 58557.7 58974.4 59817.7 61924.6 19617.0 19721.4 19866.5 20058.8 20093.4 22480.8 22749.0 22785.2 22885.0 22959.7 20508.3 20518.8 20643.8 20649.4 20757.4 19938.5 19973.3 20184.6 20458.7 21061.6 20990.6 21248.7 21295.1 21297.3 21448.4 13408.9 13997.9 14090.9 14676.0 15065.7 15903.3 16034.9 16080.7 16771.8 16892.7 03:40:12 INFO - PID 12362 | -------- Summary: end -------- 03:40:12 INFO - PID 12362 | 03:40:13 INFO - TEST-INFO | 12362: exit 0 03:40:13 INFO - TEST-OK | dromaeo_css | took 1109492ms 03:40:13 INFO - TEST-START | kraken 03:40:13 INFO - Initialising browser for kraken test... 03:40:13 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55034/getInfo.html -profile /tmp/tmp6F29zI/profile 03:40:13 INFO - TEST-INFO | started process 12715 (/builds/slave/test/build/application/firefox/firefox http://localhost:55034/getInfo.html) 03:40:18 INFO - TEST-INFO | 12715: exit 0 03:40:18 INFO - Browser initialized. 03:40:18 INFO - Running cycle 1/1 for kraken test... 03:40:18 INFO - TEST-INFO | started process 12925 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6F29zI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:40:19 INFO - PID 12925 | 03:40:19 INFO - PID 12925 | (/builds/slave/test/build/application/firefox/firefox:12974): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:40:19 INFO - PID 12925 | 03:40:30 INFO - PID 12925 | RSS: Main: 164052992 03:40:30 INFO - PID 12925 | 03:40:32 INFO - PID 12925 | Cycle 1(1): loaded http://localhost:55034/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55034/tests/kraken/driver.html?testName=audio-beat-detection) 03:40:33 INFO - PID 12925 | RSS: Main: 169615360 03:40:33 INFO - PID 12925 | 03:40:36 INFO - PID 12925 | Cycle 1(1): loaded http://localhost:55034/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55034/tests/kraken/driver.html?testName=audio-dft) 03:40:36 INFO - PID 12925 | RSS: Main: 169820160 03:40:36 INFO - PID 12925 | 03:40:39 INFO - PID 12925 | Cycle 1(1): loaded http://localhost:55034/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55034/tests/kraken/driver.html?testName=audio-fft) 03:40:40 INFO - PID 12925 | RSS: Main: 164245504 03:40:40 INFO - PID 12925 | 03:40:42 INFO - PID 12925 | Cycle 1(1): loaded http://localhost:55034/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55034/tests/kraken/driver.html?testName=audio-oscillator) 03:40:42 INFO - PID 12925 | RSS: Main: 165216256 03:40:42 INFO - PID 12925 | 03:40:45 INFO - PID 12925 | Cycle 1(1): loaded http://localhost:55034/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55034/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:40:45 INFO - PID 12925 | RSS: Main: 165023744 03:40:45 INFO - PID 12925 | 03:40:48 INFO - PID 12925 | Cycle 1(1): loaded http://localhost:55034/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55034/tests/kraken/driver.html?testName=imaging-darkroom) 03:40:49 INFO - PID 12925 | RSS: Main: 166256640 03:40:49 INFO - PID 12925 | 03:40:52 INFO - PID 12925 | Cycle 1(1): loaded http://localhost:55034/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55034/tests/kraken/driver.html?testName=imaging-desaturate) 03:40:53 INFO - PID 12925 | RSS: Main: 170045440 03:40:53 INFO - PID 12925 | 03:40:56 INFO - PID 12925 | Cycle 1(1): loaded http://localhost:55034/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55034/tests/kraken/driver.html?testName=json-parse-financial) 03:40:56 INFO - PID 12925 | RSS: Main: 168763392 03:40:56 INFO - PID 12925 | 03:40:58 INFO - PID 12925 | Cycle 1(1): loaded http://localhost:55034/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55034/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:40:59 INFO - PID 12925 | RSS: Main: 168452096 03:40:59 INFO - PID 12925 | 03:41:00 INFO - PID 12925 | Cycle 1(1): loaded http://localhost:55034/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55034/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:41:01 INFO - PID 12925 | RSS: Main: 168255488 03:41:01 INFO - PID 12925 | 03:41:03 INFO - PID 12925 | Cycle 1(1): loaded http://localhost:55034/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55034/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:41:04 INFO - PID 12925 | RSS: Main: 165515264 03:41:04 INFO - PID 12925 | 03:41:06 INFO - PID 12925 | Cycle 1(1): loaded http://localhost:55034/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55034/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:41:07 INFO - PID 12925 | RSS: Main: 165646336 03:41:07 INFO - PID 12925 | 03:41:10 INFO - PID 12925 | Cycle 1(1): loaded http://localhost:55034/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55034/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:41:10 INFO - PID 12925 | RSS: Main: 165928960 03:41:10 INFO - PID 12925 | 03:41:12 INFO - PID 12925 | Cycle 1(1): loaded http://localhost:55034/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55034/tests/kraken/driver.html?testName=ai-astar) 03:41:12 INFO - PID 12925 | RSS: Main: 167403520 03:41:12 INFO - PID 12925 | 03:41:12 INFO - PID 12925 | __start_tp_report 03:41:12 INFO - PID 12925 | _x_x_mozilla_page_load 03:41:12 INFO - PID 12925 | _x_x_mozilla_page_load_details 03:41:12 INFO - PID 12925 | |i|pagename|runs| 03:41:12 INFO - PID 12925 | |0;ai-astar;96;105;101;106;105;107;108;98;107;107 03:41:12 INFO - PID 12925 | |1;audio-beat-detection;141;112;146;174;117;139;141;116;165;113 03:41:12 INFO - PID 12925 | |2;audio-dft;162;162;163;164;164;162;163;163;169;166 03:41:12 INFO - PID 12925 | |3;audio-fft;75;76;75;140;75;75;73;87;103;75 03:41:12 INFO - PID 12925 | |4;audio-oscillator;77;78;127;78;77;78;125;78;76;138 03:41:12 INFO - PID 12925 | |5;imaging-gaussian-blur;114;114;114;114;113;114;114;114;113;114 03:41:12 INFO - PID 12925 | |6;imaging-darkroom;148;148;150;148;148;147;149;149;148;148 03:41:12 INFO - PID 12925 | |7;imaging-desaturate;95;94;94;95;94;94;94;94;94;94 03:41:12 INFO - PID 12925 | |8;json-parse-financial;47;47;47;47;47;56;59;47;48;47 03:41:12 INFO - PID 12925 | |9;json-stringify-tinderbox;54;53;57;59;53;54;53;53;53;53 03:41:12 INFO - PID 12925 | |10;stanford-crypto-aes;77;75;74;74;74;74;83;74;73;73 03:41:12 INFO - PID 12925 | |11;stanford-crypto-ccm;127;132;116;117;113;133;124;123;122;153 03:41:12 INFO - PID 12925 | |12;stanford-crypto-pbkdf2;164;165;168;165;162;164;166;185;160;159 03:41:12 INFO - PID 12925 | |13;stanford-crypto-sha256-iterative;67;61;61;62;76;64;65;59;60;66 03:41:12 INFO - PID 12925 | __end_tp_report 03:41:12 INFO - PID 12925 | __start_cc_report 03:41:12 INFO - PID 12925 | _x_x_mozilla_cycle_collect,842 03:41:12 INFO - PID 12925 | __end_cc_report 03:41:12 INFO - PID 12925 | __startTimestamp1502016072768__endTimestamp 03:41:12 INFO - PID 12925 | 03:41:12 INFO - PID 12925 | ------- Summary: start ------- 03:41:12 INFO - PID 12925 | Number of tests: 14 03:41:12 INFO - PID 12925 | 03:41:12 INFO - PID 12925 | [#0] ai-astar Cycles:10 Average:104.00 Median:107.00 stddev:4.19 (3.9%) stddev-sans-first:3.30 03:41:12 INFO - PID 12925 | Values: 96.0 105.0 101.0 106.0 105.0 107.0 108.0 98.0 107.0 107.0 03:41:12 INFO - PID 12925 | 03:41:12 INFO - PID 12925 | [#1] audio-beat-detection Cycles:10 Average:136.40 Median:141.00 stddev:21.88 (15.5%) stddev-sans-first:23.14 03:41:12 INFO - PID 12925 | Values: 141.0 112.0 146.0 174.0 117.0 139.0 141.0 116.0 165.0 113.0 03:41:12 INFO - PID 12925 | 03:41:12 INFO - PID 12925 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.50 stddev:2.20 (1.3%) stddev-sans-first:2.24 03:41:12 INFO - PID 12925 | Values: 162.0 162.0 163.0 164.0 164.0 162.0 163.0 163.0 169.0 166.0 03:41:12 INFO - PID 12925 | 03:41:12 INFO - PID 12925 | [#3] audio-fft Cycles:10 Average:85.40 Median:75.00 stddev:21.28 (28.4%) stddev-sans-first:22.24 03:41:12 INFO - PID 12925 | Values: 75.0 76.0 75.0 140.0 75.0 75.0 73.0 87.0 103.0 75.0 03:41:12 INFO - PID 12925 | 03:41:12 INFO - PID 12925 | [#4] audio-oscillator Cycles:10 Average:93.20 Median:77.50 stddev:25.62 (33.1%) stddev-sans-first:26.49 03:41:12 INFO - PID 12925 | Values: 77.0 78.0 127.0 78.0 77.0 78.0 125.0 78.0 76.0 138.0 03:41:12 INFO - PID 12925 | 03:41:12 INFO - PID 12925 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:41:12 INFO - PID 12925 | Values: 114.0 114.0 114.0 114.0 113.0 114.0 114.0 114.0 113.0 114.0 03:41:12 INFO - PID 12925 | 03:41:12 INFO - PID 12925 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 03:41:12 INFO - PID 12925 | Values: 148.0 148.0 150.0 148.0 148.0 147.0 149.0 149.0 148.0 148.0 03:41:12 INFO - PID 12925 | 03:41:12 INFO - PID 12925 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 03:41:12 INFO - PID 12925 | Values: 95.0 94.0 94.0 95.0 94.0 94.0 94.0 94.0 94.0 94.0 03:41:12 INFO - PID 12925 | 03:41:12 INFO - PID 12925 | [#8] json-parse-financial Cycles:10 Average:49.20 Median:47.00 stddev:4.44 (9.5%) stddev-sans-first:4.64 03:41:12 INFO - PID 12925 | Values: 47.0 47.0 47.0 47.0 47.0 56.0 59.0 47.0 48.0 47.0 03:41:12 INFO - PID 12925 | 03:41:12 INFO - PID 12925 | [#9] json-stringify-tinderbox Cycles:10 Average:54.20 Median:53.50 stddev:2.10 (3.9%) stddev-sans-first:2.22 03:41:12 INFO - PID 12925 | Values: 54.0 53.0 57.0 59.0 53.0 54.0 53.0 53.0 53.0 53.0 03:41:12 INFO - PID 12925 | 03:41:12 INFO - PID 12925 | [#10] stanford-crypto-aes Cycles:10 Average:75.10 Median:74.00 stddev:3.00 (4.1%) stddev-sans-first:3.10 03:41:12 INFO - PID 12925 | Values: 77.0 75.0 74.0 74.0 74.0 74.0 83.0 74.0 73.0 73.0 03:41:12 INFO - PID 12925 | 03:41:12 INFO - PID 12925 | [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:125.50 stddev:11.52 (9.2%) stddev-sans-first:12.21 03:41:12 INFO - PID 12925 | Values: 127.0 132.0 116.0 117.0 113.0 133.0 124.0 123.0 122.0 153.0 03:41:12 INFO - PID 12925 | 03:41:12 INFO - PID 12925 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.80 Median:165.00 stddev:7.27 (4.4%) stddev-sans-first:7.68 03:41:12 INFO - PID 12925 | Values: 164.0 165.0 168.0 165.0 162.0 164.0 166.0 185.0 160.0 159.0 03:41:12 INFO - PID 12925 | 03:41:12 INFO - PID 12925 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.10 Median:64.50 stddev:4.95 (7.7%) stddev-sans-first:5.14 03:41:12 INFO - PID 12925 | Values: 67.0 61.0 61.0 62.0 76.0 64.0 65.0 59.0 60.0 66.0 03:41:12 INFO - PID 12925 | -------- Summary: end -------- 03:41:12 INFO - PID 12925 | 03:41:13 INFO - PID 12925 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:41:13 INFO - TEST-INFO | 12925: exit 0 03:41:13 INFO - TEST-OK | kraken | took 60364ms 03:41:13 INFO - SUITE-END | took 1169s 03:41:13 INFO - Completed test suite (00:19:29) 03:41:13 INFO - javascript benchmark 03:41:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8892.97264829879, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3489.180042689969, 3519.1729943463283, 3533.1520435095576, 3551.9644803551955, 3580.2123532822784, 6036.818895433133, 6159.168512250856, 6226.4084911933405, 6252.781152659663, 6304.054391841226, 6131.969340153304, 6164.414380633843, 6180.690965451732, 6197.101420294055, 6206.875862482759, 5411.972940135293, 5424.783008679648, 5436.184572314165, 5444.91832622511, 5522.834314970537, 5438.619296649236, 5447.809326673567, 5466.753996070166, 5506.944930550683, 5513.255710479074, 5331.813386531453, 5389.218563308337, 5447.346318441792, 5537.224788529609, 5556.555475561966, 5353.625246232766, 5411.431799661018, 5464.12573988164, 5477.0, 5490.945090549123, 5420.051490989101, 5435.510804027656, 5442.074847275933, 5442.156465747776, 5505.6696598203835, 6043.486303664194, 6065.878682426327, 6114.05232189007, 6121.357257487989, 6146.446819786241, 6623.437007854338, 6663.167104111986, 6683.331666833278, 6684.16447944007, 6699.76550820719, 6644.235912870034, 6649.60102393858, 6657.434118099967, 6747.291534388916, 6756.797296081077, 6153.353897840751, 6219.47134493564, 6221.720022598994, 6248.468880145193, 6278.121063051222, 6825.112735344473, 6924.307569243036, 6948.444124470131, 6950.270221626757, 6996.545224560387, 6616.139901812733, 6619.702113404908, 6682.131322927989, 6695.866082678416, 6700.396964273239, 6565.474762019027, 6662.467002639777, 6748.628825414649, 6791.660416979132, 6814.352636499525, 6602.7028783704845, 6603.108580341593, 6604.570702904296, 6604.768833090819, 6653.500987425962, 6689.1972963244725, 6701.564398314192, 6709.0, 6718.294579069225, 6724.899126513106, 4799.568038876518, 4810.013947140827, 4854.854354369375, 4856.490068542752, 4860.246661767432, 4210.915781684349, 4284.036091879302, 4294.377315289265, 4296.484421869396, 4296.5273819879785, 6399.968000159969, 6423.96788016057, 6483.3516648335735, 6483.643399613066, 6497.935020649733, 6811.318868113248, 6842.144731908512, 6844.452443804484, 6846.075779769767, 6852.28051054642, 6430.7106180222, 6446.129772480749, 6460.289368169498, 6471.029345598198, 6517.739290428424, 5353.9732301338245, 5408.567314614821, 5418.051840927822, 5472.370677372073, 5474.987127381447, 7169.318914703095, 7237.457190710717, 7257.92742072583, 7265.745698900513, 7269.491135620456, 6694.799156025327, 6777.525573210025, 6833.93166068333, 6854.040434339297, 6858.0398744176855, 7008.579485230903, 7117.75087871922, 7179.353858152791, 7263.927360726325, 7273.527220730635, 6607.57050791697, 6675.198976122896, 6715.899261511179, 6720.8319792005595, 6732.899006514808, 6801.795946121624, 6847.144106986627, 6853.4859885507785, 6856.108705868205, 6859.314068593101, 6574.506911981525, 6577.6053436793945, 6581.14445122131, 6664.633445160563, 6664.900026499509, 6552.63960482159, 6588.967055164693, 6600.471962243105, 6639.834004149935, 6643.30245324234, 6539.411452969255, 6596.70314835824, 6599.406053455212, 6621.569597976116, 6632.602043877383, 6497.057926600711, 6584.341565843377, 6602.339766023551, 6643.103181070687, 6671.633060181736, 6387.489000880011, 6390.201224846895, 6423.775167869102, 6437.774677886251, 6465.159529261354], "value": 6128.605277712662, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [907.1472815553379, 940.163254703314, 966.6568368229279, 1184.7275126720854, 1205.5840734946441, 32732.509012364833, 42386.15227695448, 42794.0, 43103.137937241234, 43121.13757724844, 42921.356179657254, 43050.35424468636, 43145.0, 43217.7839110804, 43276.78361608188, 7377.63111844407, 7520.623968801566, 7521.548707077593, 7526.021617189757, 7533.35966442853, 7397.075365579302, 7449.329560339568, 7492.138404083518, 7502.212267711866, 7512.136104348016, 7513.098428188625, 7549.207333230014, 7555.16893141754, 7561.584112873789, 7565.470417070807, 7517.473776835596, 7540.962295188544, 7541.698332066738, 7543.132539757943, 7544.358729507999, 7404.4816862819625, 7442.553446793209, 7464.514806537558, 7468.365188958945, 7469.253074692541, 39645.60354396448, 39670.603293967266, 39674.60325396767, 39877.80061099676, 39993.0, 3388.8305584720665, 3464.4803279508023, 3464.5149679044953, 3469.8959031229106, 3472.3402553515, 32210.0, 32230.0, 32230.516542251884, 32310.838445807854, 32350.676493235238, 4940.0, 5084.059449001947, 5099.59203263738, 5124.743762811844, 5137.434882162959, 209062.0, 209545.0, 209962.0, 209987.0, 210566.0, 50303.49696502988, 50348.748256258485, 50497.49502505001, 50660.240096398586, 50721.0, 53088.73455632697, 53284.200736988976, 53312.20031699527, 53480.46519534755, 53498.197527037126, 15104.54686359411, 15402.691946161014, 16467.423640172536, 16493.835061649468, 16593.0, 13321.067525273138, 13356.464006639166, 13365.732685346238, 13383.598492045254, 13458.730825383438, 14766.523347665363, 14883.776743348859, 14972.775408368883, 14976.850231497545, 15003.624909377135, 5814.273215848019, 5856.912146317809, 5908.261467316585, 5929.165543340392, 5949.702514874239, 1076.2573824061528, 1100.7138144082596, 1110.8555887734542, 1117.3351855645878, 1117.776444711061, 24401.633975490382, 24942.5011499769, 25005.374865628506, 25244.49511009806, 25282.0, 1185.5080141741253, 1190.2858285028913, 1195.988040119605, 1203.668991027457, 1222.1872454817624, 13284.667883302995, 13385.732285354434, 13395.464181432828, 13431.12697674648, 13665.795013074812, 280594.0, 284964.0, 285874.0, 286159.0, 286752.0, 54201.18698219451, 54380.45619543754, 54507.0, 54607.18089228665, 54610.45389546054, 1481.7925490431348, 1516.9772453413207, 1525.4203402707121, 1536.9538913832603, 1545.8145022597134, 22878.771212287666, 23184.18855340055, 23205.651915220948, 23382.76617233806, 23704.762952370256, 38814.80592597019, 38941.80529097337, 38951.0, 39088.21823563456, 39225.411618826314, 216952.0, 217761.0, 233273.0, 240806.0, 241619.0, 35816.4627530582, 36188.63811361958, 38720.22559548737, 39768.0, 39973.800131000324, 49021.0, 49082.0, 49605.0, 49927.75180620514, 49937.0, 36076.0, 36603.26793464062, 36637.63362366342, 36897.63102368942, 37093.0, 36406.661873950914, 36444.088897777765, 36526.0, 36731.44902826406, 36982.63017369792, 42135.36796947987, 42553.57446425496, 42580.574194257664, 42639.360409594505, 42804.57195428006, 31926.840365798023, 32214.516782247818, 32573.34853302968, 32864.835675821465, 32892.671073289916, 26478.0, 27075.59386609163, 27166.1850144496, 27292.0, 27472.862635687492], "value": 18169.96685106378, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.2468569621255, 585.7539833270024, 586.7213073789949, 592.4016743089478, 596.6748122273362, 21764.782352176473, 22750.203742869002, 22762.089516419324, 22782.88608556957, 23275.767242327613, 26978.325541861464, 27430.17709468714, 27542.17373478794, 27552.0, 27586.17241482754, 6077.0884367344925, 6181.196444462236, 6187.164732761087, 6187.628742275456, 6236.345183755709, 5922.703864806764, 6128.264608247016, 6189.938100619003, 6231.22109736283, 6234.314225435199, 6166.167567378414, 6194.0, 6194.442500175006, 6195.194624698783, 6196.473299769525, 6141.416565426277, 6159.784407545737, 6208.96895515524, 6213.813585592439, 6214.8135555933395, 5769.653820770767, 5802.187693722883, 5805.10020946754, 5808.215890854723, 5808.88382232353, 30304.69695303041, 30522.694773052208, 31133.0, 31471.37057258842, 31759.0, 2212.933611991643, 2239.798418142375, 2241.6301310283784, 2246.8651880887037, 2251.718535183102, 19797.208111675514, 20430.284940027028, 20451.89774051135, 20482.18071277147, 20492.282770102975, 2387.2957477544164, 2450.8161887858305, 2458.1027924807495, 2527.545041892459, 2536.8351057181226, 149065.0, 152530.23734881254, 153320.0, 157084.0, 161030.0, 14842.257887105601, 15484.690306193814, 15780.605484862741, 15863.0, 16189.190540473164, 24373.14693985702, 24450.510989780105, 24492.38769030753, 24514.754852451246, 24520.264392068268, 10364.948175259075, 10397.792044159074, 10492.370457772558, 10524.684259472227, 10727.463626818628, 8106.9594652027545, 9599.664011759554, 9681.419114853132, 9700.223982081558, 9849.21206303494, 8660.17728315809, 9607.711768646952, 9671.17794987434, 9768.316217864682, 9857.901420985841, 2862.7852911031755, 2893.551499517578, 2901.231173738961, 2927.751141152983, 2976.6130403047464, 1042.47876061969, 1053.8103141434615, 1062.8193207154802, 1062.9202809789142, 1065.6536625596557, 21357.78642213589, 21681.699098054167, 21726.674099888514, 21772.12911483523, 21901.561968760536, 1119.8488204092507, 1119.9440027998567, 1129.8418221449003, 1130.0676941523277, 1132.1565433751907, 11604.187706860439, 11935.820962685566, 11990.400479975966, 12023.158378913393, 12066.758664826655, 581027.0, 594002.0, 595177.0, 601538.0, 607154.0, 131953.34023329822, 140332.29833850765, 140687.0, 141119.0, 142851.2857435727, 1322.6032190342858, 1326.7479178955969, 1362.0533729058407, 1368.4799776085024, 1370.1778932640336, 21022.579548409252, 21107.788922110583, 21178.364649060553, 21559.892200538896, 21594.0, 65042.07310671126, 65351.673241633485, 65392.346076538626, 65889.34110659023, 66675.0, 81543.0, 82147.12485062995, 82378.58810705908, 82642.17357826585, 85355.14644853472, 15378.846211538188, 15857.207139643202, 15931.725461963248, 15999.440019599258, 16037.67924641524, 24832.50334993326, 25122.874385627954, 25310.746892531577, 25407.0, 25807.354816129748, 20490.897545512176, 20586.27948021812, 20682.276120335715, 20720.378388648365, 20919.26782562603, 17367.30530778755, 17659.20533576018, 17960.191791369158, 18358.173882175066, 18359.632807344045, 20682.0, 20696.17215311371, 20761.273355432488, 21122.788772112082, 21133.89433052825, 15470.381184752934, 15567.377304907677, 15570.84429155694, 15703.136327502098, 15752.606184845012, 20062.197512099352, 20431.284905028253, 20972.895135524224, 21014.369568912956, 21059.473513162295], "value": 12787.589807940118, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1421.4527406948328, 1421.6090575091848, 1439.7984282200487, 1457.9927100364496, 1510.297711564123, 14791.926040369797, 15346.155961422117, 15370.07779533226, 15370.462033828804, 15863.3654653814, 15828.366865325403, 16113.033218006898, 16117.194140292997, 16127.43553975611, 16134.0, 2714.796390270728, 2795.0636536760157, 2824.15275417375, 2827.4345130973784, 2832.6034355190186, 2795.7204279572084, 2824.0398264590035, 2833.249188964926, 2834.248924035122, 2836.177508522526, 2671.7728993035516, 2737.794665400093, 2781.1934538983774, 2783.846888421136, 2785.6517935258094, 2549.413634863982, 2585.4829034193235, 2592.779613732835, 2596.4547445036565, 2645.695744989322, 2682.9865850670817, 2695.9326016849736, 2713.3352328679402, 2714.253580265443, 2716.090109813215, 15198.544043678707, 15296.0, 15503.612409689735, 15521.611959700986, 15542.766858497018, 8245.422820402575, 8517.148285171495, 8533.701320453754, 8545.230929216339, 8556.101609331055, 5479.698616576086, 5762.481376676119, 5844.649321040709, 5846.7076646167525, 5867.061270196748, 1897.5920177161977, 1959.5688948431323, 1967.9606407871763, 1996.061850930075, 1998.2306811877386, 25319.367015824566, 25781.61327580088, 25847.0, 26743.06399276016, 26995.595066074024, 7005.0893383859775, 7008.964955175192, 7059.858802823915, 7124.323189297009, 7204.135503739585, 17896.55258618545, 18258.0, 18269.908650456928, 18423.53941151482, 18470.630587388445, 7980.0, 8125.796855078552, 8140.959295203605, 8153.633086511121, 8191.590420478952, 7484.288992545699, 7580.848383032308, 7615.961920190474, 7807.921920780833, 7864.5281283123195, 5235.345581802275, 5367.4364191759305, 5390.622656414013, 5410.431904650034, 5449.264349312792, 1542.6837498312818, 1562.3594326326152, 1569.739575011979, 1577.3296349051607, 1589.570815879706, 932.2681694869494, 965.2471072563412, 972.6936015155203, 973.4743238651049, 978.3200675530438, 8037.115917249098, 8047.315978141924, 8068.1528439513, 8109.553974531457, 8133.0, 763.7785042337771, 776.1074764021421, 778.5873487051872, 782.5969625642798, 785.0461689047835, 4894.877628059327, 4925.335079764186, 4960.181570040902, 5265.420803711589, 5723.313202415737, 21958.23146189876, 22652.773472265068, 22799.202027929274, 22812.2015729452, 22835.771642283366, 21486.355409337746, 21756.78243217579, 21835.0, 22203.66694499584, 22306.888465557568, 11791.941040294916, 11968.461419236155, 12320.938395308145, 12330.260184388966, 12372.690682733004, 8763.474191548272, 9085.500297483703, 9271.953640231755, 9273.072692730673, 9291.0, 18984.240630374632, 19300.90349548243, 19301.90349048246, 19639.41081767492, 19871.801281986995, 19447.222111115396, 19719.40841774749, 19868.60262794707, 20187.293444729363, 20386.898065509577, 12818.935905320786, 13121.212727236396, 13128.409221584861, 13144.0, 13170.934145329213, 14257.714845703234, 14540.49108281205, 14618.122912625277, 14687.045342052732, 14690.0, 11680.415979201176, 11686.474108664961, 12022.63932082039, 12056.336901470504, 12166.270023798601, 11320.547178113113, 11345.659630211107, 11571.074314055024, 11700.590479333183, 11744.530218791153, 9939.403635781588, 10014.098731114234, 10110.69667909964, 10126.79746405053, 10128.898711012796, 7177.928220717726, 7212.74755383559, 7237.782866513802, 7245.746398876014, 7252.0, 7622.961885190539, 7627.351675107456, 7653.387728981779, 7717.845643086995, 7836.804079898048], "value": 6876.501293990902, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [518.4012465602231, 529.5922139952238, 544.1647071744871, 548.5940404100965, 550.1005855426376, 6076.726547305371, 6154.199839073222, 6192.78325258616, 6214.508517955692, 6218.502519798422, 6067.605605635642, 6098.17674613927, 6123.663198524079, 6127.816165515042, 6150.66171360575, 4757.381540399743, 4792.137415265251, 4848.442429120643, 4893.14369985253, 4950.579200767939, 4834.830780922668, 4851.587615052707, 4852.4662287148385, 4854.0, 4875.585575226092, 4813.109574728669, 4825.855224343258, 4839.903201935959, 4856.223004319309, 4858.319835223072, 4857.3685420895235, 4860.8055677772845, 4873.805917550188, 4879.268109783526, 4883.26750987353, 4345.67407444443, 4385.8245670173155, 4409.426774519324, 4414.977925110354, 4429.933550996738, 6006.579539432241, 6021.909671354933, 6022.6687532185715, 6026.548008899306, 6036.245469316335, 5753.597248192628, 5775.509081728016, 5790.247267855194, 5800.20193739942, 5801.245838041028, 6473.902891456632, 6546.541742078057, 6591.340865913418, 6620.23867255267, 6647.368499992493, 4848.733319667417, 4869.464358920552, 4926.704397736147, 4938.185199442088, 4985.725785081819, 6539.215294164683, 6671.4662826973245, 6770.356816102462, 6838.316168383171, 6949.583025018515, 4982.526659967298, 5003.199488081889, 5064.366954130734, 5078.21287700407, 5079.822206222764, 5128.282040514331, 5130.30740849988, 5153.149730294459, 5165.715885626327, 5174.301469301596, 5663.858403539862, 5674.319081710139, 5720.256366672389, 5735.082386818172, 5750.223719797774, 6546.967265163644, 6564.212294524687, 6588.275289718127, 6597.505187110986, 6601.481659218407, 1772.5745821002865, 1774.3434929076325, 1793.390247315919, 1794.425783749214, 1799.8380145786941, 1193.7791508570942, 1254.1033161289722, 1267.3853181207107, 1271.2563150557028, 1279.1365828066018, 6356.8410789729705, 6358.650274234869, 6363.840903977438, 6389.361063893573, 6405.743770249138, 6649.601023938482, 6661.766838160641, 6691.929291313367, 6696.7656132035145, 6743.865122697519, 6232.407921247474, 6336.841578960563, 6371.279754466268, 6374.266959299647, 6375.808725738235, 3469.965300347015, 3492.956620377057, 3507.8421471033867, 3516.7867085855337, 3537.646235376442, 7071.398931090812, 7106.395956343768, 7123.679434425463, 7137.785866424016, 7179.748708795167, 6443.775682620287, 6810.965945170342, 6829.863402732017, 6851.3491218334175, 6861.794146175623, 6976.302369762983, 7034.824129396704, 7081.92918070823, 7098.68055937484, 7183.640817959185, 6696.464282857457, 6703.631300278532, 6721.327867213239, 6740.831479213059, 6754.628495432798, 6523.412892839668, 6526.347365263436, 6584.4732421405215, 6588.571742836701, 6627.3372662733345, 7011.228764835762, 7019.403350715246, 7026.859462810613, 7061.71753129869, 7200.423966082805, 5101.46434624374, 5116.411612664591, 5118.820841270538, 5141.871453213699, 5157.149070403341, 6444.806655800334, 6461.386168314003, 6539.934600653933, 6688.966555167388, 6696.363845434676, 6386.521010924293, 6412.0, 6456.677166141768, 6465.3857883501, 6500.122483464672, 6400.743970241138, 6436.485081193587, 6485.286618472059, 6507.550997971083, 6529.84515110022, 6377.023122831937, 6378.819918315126, 6390.265119511316, 6532.608043517404, 6542.509311801729, 6460.903086453613, 6508.349165083454, 6514.804555863332, 6562.228198386313, 6563.671816409065, 6309.621422714652, 6329.936700633119, 6365.427111559982, 6374.74501019954, 6431.871362572816], "value": 5106.807417172325, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [904.4166512599373, 916.0335845682811, 942.7784470649397, 944.7732544189397, 960.7790208252104, 17637.29450821967, 18345.54136146597, 18349.26602935881, 18360.265589376424, 20230.190792368325, 21755.564888702218, 22358.21746238882, 22444.32667019988, 22491.887540562315, 22571.887140564275, 1009.924255680825, 1040.2770074798018, 1044.843273508972, 1047.732828128826, 1049.6588608702164, 1008.6699723638419, 1047.9109275711573, 1051.805415998043, 1056.5034433816095, 1056.873175218975, 1105.3423213188141, 1109.517359948425, 1112.6606385052555, 1113.120634698587, 1115.0912006714502, 1090.9236353455262, 1095.9287646303005, 1097.5884043483693, 1100.7908497385472, 1102.4267380961935, 804.0311424733183, 804.9275565199101, 805.2390490986021, 805.8589746794346, 806.7418426103649, 19836.504087397785, 20046.498837529034, 20093.296734614363, 20096.497587560283, 20875.478113047142, 21064.473388165265, 21676.458088547755, 22003.0, 22022.449438764, 22057.22799702019, 16930.915345423316, 17012.319507219698, 17017.744733829004, 17168.656626867392, 17226.56933576658, 3730.925381492355, 3765.8870233893026, 3771.15149091455, 3774.1508160663907, 3774.9811250943844, 142291.0, 145764.2711786445, 147351.26324368417, 147773.0, 150353.0, 17268.0, 17378.65242695139, 17546.847533252527, 17587.384441544484, 17659.73510397345, 32856.50715239273, 33269.0, 33373.66626333754, 33615.83192084024, 33660.66339336575, 8849.557522123869, 8934.463932164092, 8970.192682658591, 8973.37186396946, 9013.098690130935, 4139.668826493873, 4247.086876321606, 4253.829846806093, 4257.8509752158525, 4271.957280427218, 5496.422875598085, 6000.969995149996, 6247.625142491465, 6249.125122482856, 6262.718177682015, 1153.7251337272362, 1172.1033409441784, 1199.7744184537733, 1206.7827790997706, 1210.3887536794039, 734.4051318432087, 744.5160645580416, 749.9400047996256, 752.6876346316327, 766.731643924622, 13073.607791766262, 13650.522231721841, 13763.0, 14221.573352799225, 14419.134851908919, 727.4544091931052, 728.9817754556178, 731.7841236835146, 735.3235023778137, 744.7467860927202, 6319.778807741799, 6450.741970321134, 6466.967665161644, 6473.741050358027, 6554.63949482783, 124166.37916810358, 124344.0, 125666.37166814107, 126077.0, 126510.0, 109178.45410772895, 109477.0, 112303.0, 112669.4366528162, 115052.42473787577, 93540.53229733808, 96874.03125968791, 97640.51179744056, 98391.0, 99307.0, 13649.38577763983, 13732.244726539737, 13869.722605547631, 14311.57065288043, 14526.709465810836, 43839.78080109579, 46761.83095422642, 47245.0, 47929.52070479251, 49471.50528494669, 58490.0, 58557.70721146537, 58974.410255896895, 59817.700911495165, 61924.59414732233, 19617.0, 19721.40835774929, 19866.50333741668, 20058.799412005694, 20093.39719808408, 22480.775192247867, 22749.0, 22785.20251791179, 22885.0, 22959.6556051656, 20508.282210122576, 20518.794812052285, 20643.793562064788, 20649.380518584465, 20757.377278681663, 19938.501537461678, 19973.300934467225, 20184.596308073462, 20458.69311960292, 21061.57876842424, 20990.580188396452, 21248.681269780656, 21295.148194072062, 21297.254596089064, 21448.356549303546, 13408.932955335162, 13997.860021399656, 14090.929545352208, 14676.0, 15065.698686025999, 15903.284352203947, 16034.919825401264, 16080.678386431971, 16771.832281677027, 16892.746608801124], "value": 9890.823066710305, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1473.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 105.0, 101.0, 106.0, 105.0, 107.0, 108.0, 98.0, 107.0, 107.0], "value": 104.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 112.0, 146.0, 174.0, 117.0, 139.0, 141.0, 116.0, 165.0, 113.0], "value": 136.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 164.0, 164.0, 162.0, 163.0, 163.0, 169.0, 166.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 140.0, 75.0, 75.0, 73.0, 87.0, 103.0, 75.0], "value": 85.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 127.0, 78.0, 77.0, 78.0, 125.0, 78.0, 76.0, 138.0], "value": 93.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 113.0, 114.0, 114.0, 114.0, 113.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 150.0, 148.0, 148.0, 147.0, 149.0, 149.0, 148.0, 148.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 47.0, 47.0, 47.0, 47.0, 56.0, 59.0, 47.0, 48.0, 47.0], "value": 49.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 57.0, 59.0, 53.0, 54.0, 53.0, 53.0, 53.0, 53.0], "value": 54.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 74.0, 74.0, 74.0, 74.0, 83.0, 74.0, 73.0, 73.0], "value": 75.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 132.0, 116.0, 117.0, 113.0, 133.0, 124.0, 123.0, 122.0, 153.0], "value": 126.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 168.0, 165.0, 162.0, 164.0, 166.0, 185.0, 160.0, 159.0], "value": 165.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 61.0, 61.0, 62.0, 76.0, 64.0, 65.0, 59.0, 60.0, 66.0], "value": 64.1, "unit": "score"}]}]} 03:41:13 INFO - Return code: 0 03:41:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:41:13 INFO - # TBPL SUCCESS # 03:41:13 INFO - Running post-action listener: _package_coverage_data 03:41:13 INFO - Running post-action listener: _resource_record_post_action 03:41:13 INFO - [mozharness: 2017-08-06 10:41:13.561194Z] Finished run-tests step (success) 03:41:13 INFO - Running post-run listener: _resource_record_post_run 03:41:13 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 428310528; Read time: 120; Write time: 264864 03:41:13 INFO - TinderboxPrint: CPU usage
13.1% 03:41:13 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 120 03:41:13 INFO - TinderboxPrint: I/O write bytes / time
428,310,528 / 264,864 03:41:13 INFO - TinderboxPrint: CPU idle
8,235.0 (86.9%) 03:41:13 INFO - TinderboxPrint: CPU user
1,190.5 (12.6%) 03:41:13 INFO - TinderboxPrint: Swap in / out
0 / 0 03:41:13 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 108167168; Read time: 0; Write time: 86432 03:41:13 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:41:13 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 4096; Write bytes: 319746048; Read time: 120; Write time: 178428 03:41:14 INFO - Running post-run listener: _upload_blobber_files 03:41:14 INFO - Blob upload gear active. 03:41:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:41:14 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:41:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:41:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:41:14 INFO - (blobuploader) - INFO - Open directory for files ... 03:41:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:41:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:41:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:41:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:41:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:41:15 INFO - (blobuploader) - INFO - Done attempting. 03:41:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:41:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:41:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:41:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:41:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:41:16 INFO - (blobuploader) - INFO - Done attempting. 03:41:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:41:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:41:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:41:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:41:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:41:22 INFO - (blobuploader) - INFO - Done attempting. 03:41:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:41:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:41:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:41:23 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:41:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:41:23 INFO - (blobuploader) - INFO - Done attempting. 03:41:23 INFO - (blobuploader) - INFO - Iteration through files over. 03:41:23 INFO - Return code: 0 03:41:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:41:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:41:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7bbff5edf2fc7166cec1cd4688ec37f62217810bf92a3422c77dc6ec3cea2ede707408c1a976588afc505be0c5cf694a165af64efb3c3bf337fdd97c5828f955", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/54adb61d41da5c948c1f307796bb53366ecfd1dd3a6a9060cb0649626acd274f05d7e4edddce57ca35d08c48847c8b56d923e067bdc4f9603820fa4be3c73c99", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb8a208a3a9e9a296b844d53a9501d60807fbadc82765c8c6c978b1bff7ae3f7253bc62b8412d1280deb80d35b3ae1af369cb841c6010576bad511bb6167546b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c6bd3147bbbfcfeb7c157e6f6dc3c18aafe57c9b72748ef60b87b0e35652ed25cfb25b42eed30dd5ef69da516906a0abf2915824d15a8c07e6b8103ae2b1e8f"} 03:41:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:41:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:41:23 INFO - Contents: 03:41:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7bbff5edf2fc7166cec1cd4688ec37f62217810bf92a3422c77dc6ec3cea2ede707408c1a976588afc505be0c5cf694a165af64efb3c3bf337fdd97c5828f955", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/54adb61d41da5c948c1f307796bb53366ecfd1dd3a6a9060cb0649626acd274f05d7e4edddce57ca35d08c48847c8b56d923e067bdc4f9603820fa4be3c73c99", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb8a208a3a9e9a296b844d53a9501d60807fbadc82765c8c6c978b1bff7ae3f7253bc62b8412d1280deb80d35b3ae1af369cb841c6010576bad511bb6167546b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c6bd3147bbbfcfeb7c157e6f6dc3c18aafe57c9b72748ef60b87b0e35652ed25cfb25b42eed30dd5ef69da516906a0abf2915824d15a8c07e6b8103ae2b1e8f"} 03:41:23 INFO - Running post-run listener: copy_logs_to_upload_dir 03:41:23 INFO - Copying logs to upload dir... 03:41:23 INFO - mkdir: /builds/slave/test/build/upload/logs 03:41:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.867756 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-08-06 03:41:23.890175) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-06 03:41:23.896807) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1502014223.252976-1781452603 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/7bbff5edf2fc7166cec1cd4688ec37f62217810bf92a3422c77dc6ec3cea2ede707408c1a976588afc505be0c5cf694a165af64efb3c3bf337fdd97c5828f955", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/54adb61d41da5c948c1f307796bb53366ecfd1dd3a6a9060cb0649626acd274f05d7e4edddce57ca35d08c48847c8b56d923e067bdc4f9603820fa4be3c73c99", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb8a208a3a9e9a296b844d53a9501d60807fbadc82765c8c6c978b1bff7ae3f7253bc62b8412d1280deb80d35b3ae1af369cb841c6010576bad511bb6167546b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c6bd3147bbbfcfeb7c157e6f6dc3c18aafe57c9b72748ef60b87b0e35652ed25cfb25b42eed30dd5ef69da516906a0abf2915824d15a8c07e6b8103ae2b1e8f"} build_url:https://queue.taskcluster.net/v1/task/c8lVeiZqRpeG8wBPzFBa7g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011237 build_url: 'https://queue.taskcluster.net/v1/task/c8lVeiZqRpeG8wBPzFBa7g/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7bbff5edf2fc7166cec1cd4688ec37f62217810bf92a3422c77dc6ec3cea2ede707408c1a976588afc505be0c5cf694a165af64efb3c3bf337fdd97c5828f955", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/54adb61d41da5c948c1f307796bb53366ecfd1dd3a6a9060cb0649626acd274f05d7e4edddce57ca35d08c48847c8b56d923e067bdc4f9603820fa4be3c73c99", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb8a208a3a9e9a296b844d53a9501d60807fbadc82765c8c6c978b1bff7ae3f7253bc62b8412d1280deb80d35b3ae1af369cb841c6010576bad511bb6167546b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c6bd3147bbbfcfeb7c157e6f6dc3c18aafe57c9b72748ef60b87b0e35652ed25cfb25b42eed30dd5ef69da516906a0abf2915824d15a8c07e6b8103ae2b1e8f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-06 03:41:23.928694) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 03:41:23.929031) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1502014223.252976-1781452603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004452 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 03:41:24.008115) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-06 03:41:24.011474) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-06 03:41:24.011811) ========= ========= Total master_lag: 0.21 =========