builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-043 starttime: 1502448671.61 results: success (0) revision: 64f5e3f40f0e7accb12cd90080e58eff0be46383 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-11 03:51:11.606109) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-11 03:51:11.606914) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-11 03:51:11.607408) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-11 03:51:11.627154) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 03:51:11.627834) ========= 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=d2a8c569965ab8367867b893000001a1-1502448671.107665-135259192 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-11 03:51:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.5M=0s 2017-08-11 03:51:11 (69.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.157169 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 03:51:11.801595) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 03:51:11.802109) ========= 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=d2a8c569965ab8367867b893000001a1-1502448671.107665-135259192 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017980 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 03:51:11.852816) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 03:51:11.853239) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 64f5e3f40f0e7accb12cd90080e58eff0be46383 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 64f5e3f40f0e7accb12cd90080e58eff0be46383 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d2a8c569965ab8367867b893000001a1-1502448671.107665-135259192 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-11 03:51:11,970 truncating revision to first 12 chars 2017-08-11 03:51:11,970 Setting DEBUG logging. 2017-08-11 03:51:11,970 attempt 1/10 2017-08-11 03:51:11,971 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/64f5e3f40f0e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-11 03:51:12,276 unpacking tar archive at: mozilla-central-64f5e3f40f0e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.605552 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 03:51:12.472402) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-11 03:51:12.472771) ========= script_repo_revision: 64f5e3f40f0e7accb12cd90080e58eff0be46383 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-11 03:51:12.473178) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-11 03:51:12.473471) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-11 03:51:12.482840) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-08-11 03:51:12.483278) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=d2a8c569965ab8367867b893000001a1-1502448671.107665-135259192 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:51:12 INFO - MultiFileLogger online at 20170811 03:51:12 in /builds/slave/test 03:51:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 03:51:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:51:12 INFO - {'append_to_log': False, 03:51:12 INFO - 'base_work_dir': '/builds/slave/test', 03:51:12 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:51:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:51:12 INFO - 'branch': 'Firefox-Non-PGO', 03:51:12 INFO - 'buildbot_json_path': 'buildprops.json', 03:51:12 INFO - 'code_coverage': False, 03:51:12 INFO - 'config_files': ('talos/linux_config.py',), 03:51:12 INFO - 'default_actions': ('clobber', 03:51:12 INFO - 'read-buildbot-config', 03:51:12 INFO - 'download-and-extract', 03:51:12 INFO - 'populate-webroot', 03:51:12 INFO - 'create-virtualenv', 03:51:12 INFO - 'install', 03:51:12 INFO - 'setup-mitmproxy', 03:51:12 INFO - 'run-tests'), 03:51:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:51:12 INFO - 'disable_ccov_upload': False, 03:51:12 INFO - 'download_minidump_stackwalk': True, 03:51:12 INFO - 'download_symbols': 'ondemand', 03:51:12 INFO - 'enable_stylo': False, 03:51:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:51:12 INFO - 'tooltool.py': '/tools/tooltool.py', 03:51:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:51:12 INFO - '/tools/misc-python/virtualenv.py')}, 03:51:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:51:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:51:12 INFO - 'gecko_profile': False, 03:51:12 INFO - 'gecko_profile_interval': 0, 03:51:12 INFO - 'installer_path': 'installer.exe', 03:51:12 INFO - 'log_level': 'info', 03:51:12 INFO - 'log_name': 'talos', 03:51:12 INFO - 'log_to_console': True, 03:51:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:51:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:51:12 INFO - 'opt_config_files': (), 03:51:12 INFO - 'pip_index': False, 03:51:12 INFO - 'suite': 'dromaeojs-e10s', 03:51:12 INFO - 'system_bits': '32', 03:51:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:51:12 INFO - 'title': 'talos-linux64-ix-043', 03:51:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:51:12 INFO - 'use_talos_json': True, 03:51:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:51:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:51:12 INFO - 'work_dir': 'build'} 03:51:12 INFO - [mozharness: 2017-08-11 10:51:12.714136Z] Running clobber step. 03:51:12 INFO - Running pre-action listener: _resource_record_pre_action 03:51:12 INFO - Running main action method: clobber 03:51:12 INFO - rmtree: /builds/slave/test/build 03:51:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:51:13 INFO - Running post-action listener: _resource_record_post_action 03:51:13 INFO - [mozharness: 2017-08-11 10:51:13.732598Z] Finished clobber step (success) 03:51:13 INFO - [mozharness: 2017-08-11 10:51:13.732702Z] Running read-buildbot-config step. 03:51:13 INFO - Running pre-action listener: _resource_record_pre_action 03:51:13 INFO - Running main action method: read_buildbot_config 03:51:13 INFO - Using buildbot properties: 03:51:13 INFO - { 03:51:13 INFO - "project": "", 03:51:13 INFO - "product": "firefox", 03:51:13 INFO - "who": "archaeopteryx@coole-files.de", 03:51:13 INFO - "installer_path": "public/build/target.tar.bz2", 03:51:13 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:51:13 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:51:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 03:51:13 INFO - "stage_platform": "linux64", 03:51:13 INFO - "basedir": "/builds/slave/test", 03:51:13 INFO - "buildnumber": 1071, 03:51:13 INFO - "platform": "ubuntu64_hw", 03:51:13 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:51:13 INFO - "slavebuilddir": "test", 03:51:13 INFO - "taskId": "JZU9QYVuRy-aUoCdOAGtQw", 03:51:13 INFO - "branch": "mozilla-central", 03:51:13 INFO - "script_repo_revision": "production", 03:51:13 INFO - "revision": "64f5e3f40f0e7accb12cd90080e58eff0be46383", 03:51:13 INFO - "slavename": "talos-linux64-ix-043", 03:51:13 INFO - "repo_path": "mozilla-central" 03:51:13 INFO - } 03:51:13 INFO - Finding installer, test and symbols from parent task. 03:51:13 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JZU9QYVuRy-aUoCdOAGtQw'}, attempt #1 03:51:14 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JZU9QYVuRy-aUoCdOAGtQw'}, attempt #1 03:51:14 INFO - Task dependencies: DccvNO8hRT2EKCynlXqtsg 03:51:14 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg'}, attempt #1 03:51:15 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.tar.bz2 03:51:15 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.test_packages.json 03:51:15 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.crashreporter-symbols.zip 03:51:15 INFO - Running post-action listener: _resource_record_post_action 03:51:15 INFO - [mozharness: 2017-08-11 10:51:15.104129Z] Finished read-buildbot-config step (success) 03:51:15 INFO - [mozharness: 2017-08-11 10:51:15.104349Z] Running download-and-extract step. 03:51:15 INFO - Running pre-action listener: _resource_record_pre_action 03:51:15 INFO - Running main action method: download_and_extract 03:51:15 INFO - mkdir: /builds/slave/test/build/tests 03:51:15 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:51:15 INFO - trying https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.test_packages.json 03:51:15 INFO - Downloading https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:51:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:51:15 INFO - Downloaded 989 bytes. 03:51:15 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:51:15 INFO - Using the following test package requirements: 03:51:15 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:51:15 INFO - u'common': [u'target.common.tests.zip'], 03:51:15 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:51:15 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:51:15 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:51:15 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:51:15 INFO - u'mozbase': [u'target.common.tests.zip'], 03:51:15 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:51:15 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:51:15 INFO - u'web-platform': [u'target.common.tests.zip', 03:51:15 INFO - u'target.web-platform.tests.tar.gz'], 03:51:15 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:51:15 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:51:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.common.tests.zip 03:51:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:51:15 INFO - Fetch https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.common.tests.zip into memory 03:51:16 INFO - Content-Length response header: 54036596 03:51:16 INFO - Bytes received: 54036596 03:51:27 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:51:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.common.tests.zip 03:51:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:51:27 INFO - Fetch https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.common.tests.zip into memory 03:51:28 INFO - Content-Length response header: 54036596 03:51:28 INFO - Bytes received: 54036596 03:51:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.talos.tests.zip 03:51:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:51:40 INFO - Fetch https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.talos.tests.zip into memory 03:51:41 INFO - Content-Length response header: 14496050 03:51:41 INFO - Bytes received: 14496050 03:51:41 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:51:41 INFO - trying https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.tar.bz2 03:51:41 INFO - Downloading https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:51:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:51:42 INFO - Downloaded 61791336 bytes. 03:51:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.tar.bz2 03:51:42 INFO - mkdir: /builds/slave/test/properties 03:51:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:51:42 INFO - Writing to file /builds/slave/test/properties/build_url 03:51:42 INFO - Contents: 03:51:42 INFO - build_url:https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.tar.bz2 03:51:42 INFO - Running post-action listener: _resource_record_post_action 03:51:42 INFO - Running post-action listener: set_extra_try_arguments 03:51:42 INFO - [mozharness: 2017-08-11 10:51:42.967243Z] Finished download-and-extract step (success) 03:51:42 INFO - [mozharness: 2017-08-11 10:51:42.967340Z] Running populate-webroot step. 03:51:42 INFO - Running pre-action listener: _resource_record_pre_action 03:51:42 INFO - Running main action method: populate_webroot 03:51:42 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:51:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:51:42 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:51:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:51:42 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:51:42 INFO - 'tests': ['damp', 'tps']}, 03:51:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:51:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:51:42 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:51:42 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:51:42 INFO - 'other-e10s': {'tests': ['a11yr', 03:51:42 INFO - 'ts_paint', 03:51:42 INFO - 'tpaint', 03:51:42 INFO - 'sessionrestore', 03:51:42 INFO - 'sessionrestore_many_windows', 03:51:42 INFO - 'sessionrestore_no_auto_restore', 03:51:42 INFO - 'tabpaint']}, 03:51:42 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:51:42 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:51:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:51:42 INFO - 'tsvgr_opacity', 03:51:42 INFO - 'tart', 03:51:42 INFO - 'tscrollx', 03:51:42 INFO - 'tsvg_static']}, 03:51:42 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:51:42 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:51:42 INFO - 'talos_options': ['--mitmproxy', 03:51:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:51:42 INFO - '--firstNonBlankPaint'], 03:51:42 INFO - 'tests': ['tp6_google', 03:51:42 INFO - 'tp6_youtube', 03:51:42 INFO - 'tp6_amazon', 03:51:42 INFO - 'tp6_facebook']}, 03:51:42 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:51:42 INFO - 'talos_options': ['--stylo', 03:51:42 INFO - '--mitmproxy', 03:51:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:51:42 INFO - '--firstNonBlankPaint'], 03:51:42 INFO - 'tests': ['tp6_google', 03:51:42 INFO - 'tp6_youtube', 03:51:42 INFO - 'tp6_amazon', 03:51:42 INFO - 'tp6_facebook']}, 03:51:42 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:51:42 INFO - 'talos_options': ['--stylo', 03:51:42 INFO - '--stylo-threads=1', 03:51:42 INFO - '--mitmproxy', 03:51:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:51:42 INFO - '--firstNonBlankPaint'], 03:51:42 INFO - 'tests': ['tp6_google', 03:51:42 INFO - 'tp6_youtube', 03:51:42 INFO - 'tp6_amazon', 03:51:42 INFO - 'tp6_facebook']}, 03:51:42 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:51:42 INFO - 'talos_options': ['--xperf_path', 03:51:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:51:42 INFO - 'tests': ['tp5n']}}} 03:51:42 INFO - Running post-action listener: _resource_record_post_action 03:51:42 INFO - [mozharness: 2017-08-11 10:51:42.975724Z] Finished populate-webroot step (success) 03:51:42 INFO - [mozharness: 2017-08-11 10:51:42.975814Z] Running create-virtualenv step. 03:51:42 INFO - Running pre-action listener: _resource_record_pre_action 03:51:42 INFO - Running main action method: create_virtualenv 03:51:42 INFO - Creating virtualenv /builds/slave/test/build/venv 03:51:42 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:51:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:51:42 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:51:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:51:43 INFO - Using real prefix '/usr' 03:51:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:51:43 INFO - Installing distribute.............................................................................................................................................................................................done. 03:51:45 INFO - Installing pip.................done. 03:51:45 INFO - Return code: 0 03:51:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:51:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:51:45 INFO - Reading from file tmpfile_stdout 03:51:45 INFO - Output received: 03:51:45 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:51:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:51:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xab71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc84a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe25b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe28f00>, '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 0xe23ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe24050>, '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': 'd2a8c569965ab8367867b893000001a1-1502448671.107665-135259192', '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:51:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:51:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:51:45 INFO - Using env: {'DISPLAY': ':0', 03:51:45 INFO - 'HOME': '/home/cltbld', 03:51:45 INFO - 'LANG': 'en_US.UTF-8', 03:51:45 INFO - 'LANGUAGE': 'en_US:en', 03:51:45 INFO - 'LOGNAME': 'cltbld', 03:51:45 INFO - 'MAIL': '/var/mail/cltbld', 03:51:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:45 INFO - 'MOZ_NO_REMOTE': '1', 03:51:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:45 INFO - 'NO_EM_RESTART': '1', 03:51:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:45 INFO - 'PWD': '/builds/slave/test', 03:51:45 INFO - 'SHELL': '/bin/bash', 03:51:45 INFO - 'SHLVL': '1', 03:51:45 INFO - 'TERM': 'linux', 03:51:45 INFO - 'TMOUT': '86400', 03:51:45 INFO - 'USER': 'cltbld', 03:51:45 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1502448671.107665-135259192', 03:51:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:45 INFO - '_': '/tools/buildbot/bin/python'} 03:51:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:45 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:51:45 INFO - Cleaning up... 03:51:45 INFO - Return code: 0 03:51:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:51:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xab71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc84a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe25b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe28f00>, '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 0xe23ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe24050>, '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': 'd2a8c569965ab8367867b893000001a1-1502448671.107665-135259192', '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:51:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:51:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:51:45 INFO - Using env: {'DISPLAY': ':0', 03:51:45 INFO - 'HOME': '/home/cltbld', 03:51:45 INFO - 'LANG': 'en_US.UTF-8', 03:51:45 INFO - 'LANGUAGE': 'en_US:en', 03:51:45 INFO - 'LOGNAME': 'cltbld', 03:51:45 INFO - 'MAIL': '/var/mail/cltbld', 03:51:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:45 INFO - 'MOZ_NO_REMOTE': '1', 03:51:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:45 INFO - 'NO_EM_RESTART': '1', 03:51:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:45 INFO - 'PWD': '/builds/slave/test', 03:51:45 INFO - 'SHELL': '/bin/bash', 03:51:45 INFO - 'SHLVL': '1', 03:51:45 INFO - 'TERM': 'linux', 03:51:45 INFO - 'TMOUT': '86400', 03:51:45 INFO - 'USER': 'cltbld', 03:51:45 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1502448671.107665-135259192', 03:51:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:45 INFO - '_': '/tools/buildbot/bin/python'} 03:51:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:46 INFO - Downloading/unpacking psutil>=3.1.1 03:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:51:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:51:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:51:47 INFO - Installing collected packages: psutil 03:51:47 INFO - Running setup.py install for psutil 03:51:47 INFO - building 'psutil._psutil_linux' extension 03:51:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:51:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:51:47 INFO - building 'psutil._psutil_posix' extension 03:51:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:51:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:51:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:51:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:51:47 INFO - Successfully installed psutil 03:51:47 INFO - Cleaning up... 03:51:47 INFO - Return code: 0 03:51:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:51:47 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:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:47 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:51:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:47 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 0xab71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc84a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe25b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe28f00>, '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 0xe23ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe24050>, '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': 'd2a8c569965ab8367867b893000001a1-1502448671.107665-135259192', '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:51:47 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:51:47 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:51:47 INFO - Using env: {'DISPLAY': ':0', 03:51:47 INFO - 'HOME': '/home/cltbld', 03:51:47 INFO - 'LANG': 'en_US.UTF-8', 03:51:47 INFO - 'LANGUAGE': 'en_US:en', 03:51:47 INFO - 'LOGNAME': 'cltbld', 03:51:47 INFO - 'MAIL': '/var/mail/cltbld', 03:51:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:47 INFO - 'MOZ_NO_REMOTE': '1', 03:51:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:47 INFO - 'NO_EM_RESTART': '1', 03:51:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:47 INFO - 'PWD': '/builds/slave/test', 03:51:47 INFO - 'SHELL': '/bin/bash', 03:51:47 INFO - 'SHLVL': '1', 03:51:47 INFO - 'TERM': 'linux', 03:51:47 INFO - 'TMOUT': '86400', 03:51:47 INFO - 'USER': 'cltbld', 03:51:47 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1502448671.107665-135259192', 03:51:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:47 INFO - '_': '/tools/buildbot/bin/python'} 03:51:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:51:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:51:49 INFO - Installing collected packages: mozsystemmonitor 03:51:49 INFO - Running setup.py install for mozsystemmonitor 03:51:49 INFO - Successfully installed mozsystemmonitor 03:51:49 INFO - Cleaning up... 03:51:49 INFO - Return code: 0 03:51:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xab71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc84a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe25b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe28f00>, '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 0xe23ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe24050>, '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': 'd2a8c569965ab8367867b893000001a1-1502448671.107665-135259192', '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:51:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:51:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:51:49 INFO - Using env: {'DISPLAY': ':0', 03:51:49 INFO - 'HOME': '/home/cltbld', 03:51:49 INFO - 'LANG': 'en_US.UTF-8', 03:51:49 INFO - 'LANGUAGE': 'en_US:en', 03:51:49 INFO - 'LOGNAME': 'cltbld', 03:51:49 INFO - 'MAIL': '/var/mail/cltbld', 03:51:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:49 INFO - 'MOZ_NO_REMOTE': '1', 03:51:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:49 INFO - 'NO_EM_RESTART': '1', 03:51:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:49 INFO - 'PWD': '/builds/slave/test', 03:51:49 INFO - 'SHELL': '/bin/bash', 03:51:49 INFO - 'SHLVL': '1', 03:51:49 INFO - 'TERM': 'linux', 03:51:49 INFO - 'TMOUT': '86400', 03:51:49 INFO - 'USER': 'cltbld', 03:51:49 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1502448671.107665-135259192', 03:51:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:49 INFO - '_': '/tools/buildbot/bin/python'} 03:51:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:49 INFO - Downloading/unpacking jsonschema==2.5.1 03:51:49 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:51:49 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:51:49 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:51:49 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:51:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:51:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:50 INFO - Downloading functools32-3.2.3-2.tar.gz 03:51:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:51:50 INFO - warning: no files found matching '*.txt' 03:51:50 INFO - no previously-included directories found matching 'build' 03:51:50 INFO - no previously-included directories found matching 'dist' 03:51:50 INFO - no previously-included directories found matching '.git*' 03:51:50 INFO - Installing collected packages: jsonschema, functools32 03:51:50 INFO - Running setup.py install for functools32 03:51:51 INFO - warning: no files found matching '*.txt' 03:51:51 INFO - no previously-included directories found matching 'build' 03:51:51 INFO - no previously-included directories found matching 'dist' 03:51:51 INFO - no previously-included directories found matching '.git*' 03:51:51 INFO - Successfully installed jsonschema functools32 03:51:51 INFO - Cleaning up... 03:51:51 INFO - Return code: 0 03:51:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:51:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xab71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc84a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe25b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe28f00>, '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 0xe23ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe24050>, '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': 'd2a8c569965ab8367867b893000001a1-1502448671.107665-135259192', '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:51:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:51:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:51:51 INFO - Using env: {'DISPLAY': ':0', 03:51:51 INFO - 'HOME': '/home/cltbld', 03:51:51 INFO - 'LANG': 'en_US.UTF-8', 03:51:51 INFO - 'LANGUAGE': 'en_US:en', 03:51:51 INFO - 'LOGNAME': 'cltbld', 03:51:51 INFO - 'MAIL': '/var/mail/cltbld', 03:51:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:51 INFO - 'MOZ_NO_REMOTE': '1', 03:51:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:51 INFO - 'NO_EM_RESTART': '1', 03:51:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:51 INFO - 'PWD': '/builds/slave/test', 03:51:51 INFO - 'SHELL': '/bin/bash', 03:51:51 INFO - 'SHLVL': '1', 03:51:51 INFO - 'TERM': 'linux', 03:51:51 INFO - 'TMOUT': '86400', 03:51:51 INFO - 'USER': 'cltbld', 03:51:51 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1502448671.107665-135259192', 03:51:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:51 INFO - '_': '/tools/buildbot/bin/python'} 03:51:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:51:51 INFO - Cleaning up... 03:51:51 INFO - Return code: 0 03:51:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:51:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xab71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc84a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe25b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe28f00>, '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 0xe23ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe24050>, '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': 'd2a8c569965ab8367867b893000001a1-1502448671.107665-135259192', '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:51:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:51:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:51:51 INFO - Using env: {'DISPLAY': ':0', 03:51:51 INFO - 'HOME': '/home/cltbld', 03:51:51 INFO - 'LANG': 'en_US.UTF-8', 03:51:51 INFO - 'LANGUAGE': 'en_US:en', 03:51:51 INFO - 'LOGNAME': 'cltbld', 03:51:51 INFO - 'MAIL': '/var/mail/cltbld', 03:51:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:51 INFO - 'MOZ_NO_REMOTE': '1', 03:51:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:51 INFO - 'NO_EM_RESTART': '1', 03:51:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:51 INFO - 'PWD': '/builds/slave/test', 03:51:51 INFO - 'SHELL': '/bin/bash', 03:51:51 INFO - 'SHLVL': '1', 03:51:51 INFO - 'TERM': 'linux', 03:51:51 INFO - 'TMOUT': '86400', 03:51:51 INFO - 'USER': 'cltbld', 03:51:51 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1502448671.107665-135259192', 03:51:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:51 INFO - '_': '/tools/buildbot/bin/python'} 03:51:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:51 INFO - Downloading/unpacking blobuploader==1.2.4 03:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:52 INFO - Downloading blobuploader-1.2.4.tar.gz 03:51:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:51:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:51:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:53 INFO - Downloading docopt-0.6.1.tar.gz 03:51:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:51:53 INFO - Installing collected packages: blobuploader, requests, docopt 03:51:53 INFO - Running setup.py install for blobuploader 03:51:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:51:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:51:53 INFO - Running setup.py install for requests 03:51:53 INFO - Running setup.py install for docopt 03:51:53 INFO - Successfully installed blobuploader requests docopt 03:51:53 INFO - Cleaning up... 03:51:53 INFO - Return code: 0 03:51:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:53 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 0xab71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc84a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe25b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe28f00>, '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 0xe23ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe24050>, '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': 'd2a8c569965ab8367867b893000001a1-1502448671.107665-135259192', '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:51:53 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:51:53 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:51:53 INFO - Using env: {'DISPLAY': ':0', 03:51:53 INFO - 'HOME': '/home/cltbld', 03:51:53 INFO - 'LANG': 'en_US.UTF-8', 03:51:53 INFO - 'LANGUAGE': 'en_US:en', 03:51:53 INFO - 'LOGNAME': 'cltbld', 03:51:53 INFO - 'MAIL': '/var/mail/cltbld', 03:51:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:53 INFO - 'MOZ_NO_REMOTE': '1', 03:51:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:53 INFO - 'NO_EM_RESTART': '1', 03:51:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:53 INFO - 'PWD': '/builds/slave/test', 03:51:53 INFO - 'SHELL': '/bin/bash', 03:51:53 INFO - 'SHLVL': '1', 03:51:53 INFO - 'TERM': 'linux', 03:51:53 INFO - 'TMOUT': '86400', 03:51:53 INFO - 'USER': 'cltbld', 03:51:53 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1502448671.107665-135259192', 03:51:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:53 INFO - '_': '/tools/buildbot/bin/python'} 03:51:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:51:54 INFO - Running setup.py (path:/tmp/pip-h1OixS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:51:54 INFO - Running setup.py (path:/tmp/pip-9gZups-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:51:54 INFO - Running setup.py (path:/tmp/pip-Qn14Ux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:51:54 INFO - Running setup.py (path:/tmp/pip-Y2tWNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:51:54 INFO - Running setup.py (path:/tmp/pip-U2jZHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:51:54 INFO - Running setup.py (path:/tmp/pip-6bOvrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:51:54 INFO - Running setup.py (path:/tmp/pip-ouN75R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:51:54 INFO - Running setup.py (path:/tmp/pip-TmV70w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:51:54 INFO - Running setup.py (path:/tmp/pip-DA46LR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:51:54 INFO - Running setup.py (path:/tmp/pip-XOGKFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:51:54 INFO - Running setup.py (path:/tmp/pip-8YEfME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:51:54 INFO - Running setup.py (path:/tmp/pip-qixptM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:51:54 INFO - Running setup.py (path:/tmp/pip-cHfmoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:51:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:51:55 INFO - Running setup.py (path:/tmp/pip-nmwUDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:51:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:51:55 INFO - Running setup.py (path:/tmp/pip-bS4thN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:51:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:51:55 INFO - Running setup.py (path:/tmp/pip-GmCzmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:51:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:51:55 INFO - Running setup.py (path:/tmp/pip-lood0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:51:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:51:55 INFO - Running setup.py install for manifestparser 03:51:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:51:55 INFO - Running setup.py install for mozcrash 03:51:55 INFO - Running setup.py install for mozdebug 03:51:55 INFO - Running setup.py install for mozdevice 03:51:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:51:55 INFO - Running setup.py install for mozfile 03:51:55 INFO - Running setup.py install for mozhttpd 03:51:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:51:55 INFO - Running setup.py install for mozinfo 03:51:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:51:56 INFO - Running setup.py install for mozInstall 03:51:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:51:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:51:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:51:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:51:56 INFO - Running setup.py install for mozleak 03:51:56 INFO - Running setup.py install for mozlog 03:51:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:51:56 INFO - Running setup.py install for moznetwork 03:51:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:51:56 INFO - Running setup.py install for mozprocess 03:51:56 INFO - Running setup.py install for mozprofile 03:51:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:51:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:51:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:51:56 INFO - Running setup.py install for mozrunner 03:51:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:51:56 INFO - Running setup.py install for mozscreenshot 03:51:56 INFO - Running setup.py install for moztest 03:51:57 INFO - Running setup.py install for mozversion 03:51:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:51:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:51:57 INFO - Cleaning up... 03:51:57 INFO - Return code: 0 03:51:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:51:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xab71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc84a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe25b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe28f00>, '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 0xe23ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe24050>, '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': 'd2a8c569965ab8367867b893000001a1-1502448671.107665-135259192', '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:51:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:51:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:51:57 INFO - Using env: {'DISPLAY': ':0', 03:51:57 INFO - 'HOME': '/home/cltbld', 03:51:57 INFO - 'LANG': 'en_US.UTF-8', 03:51:57 INFO - 'LANGUAGE': 'en_US:en', 03:51:57 INFO - 'LOGNAME': 'cltbld', 03:51:57 INFO - 'MAIL': '/var/mail/cltbld', 03:51:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:57 INFO - 'MOZ_NO_REMOTE': '1', 03:51:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:57 INFO - 'NO_EM_RESTART': '1', 03:51:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:57 INFO - 'PWD': '/builds/slave/test', 03:51:57 INFO - 'SHELL': '/bin/bash', 03:51:57 INFO - 'SHLVL': '1', 03:51:57 INFO - 'TERM': 'linux', 03:51:57 INFO - 'TMOUT': '86400', 03:51:57 INFO - 'USER': 'cltbld', 03:51:57 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1502448671.107665-135259192', 03:51:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:57 INFO - '_': '/tools/buildbot/bin/python'} 03:51:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:51:57 INFO - Running setup.py (path:/tmp/pip-A4Xexr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:51:57 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:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:51:57 INFO - Running setup.py (path:/tmp/pip-ff2RAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:51:57 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:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:51:57 INFO - Running setup.py (path:/tmp/pip-PhsAO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:51:57 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:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:51:57 INFO - Running setup.py (path:/tmp/pip-5dQdeA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:51:57 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:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:51:57 INFO - Running setup.py (path:/tmp/pip-Qn982O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:51:57 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:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:51:57 INFO - Running setup.py (path:/tmp/pip-OlofBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:51:57 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:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:51:57 INFO - Running setup.py (path:/tmp/pip-z25uKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:51:57 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:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:51:57 INFO - Running setup.py (path:/tmp/pip-eLDaHV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:51:57 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:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:51:57 INFO - Running setup.py (path:/tmp/pip-hTY2z4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:51:57 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:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:51:57 INFO - Running setup.py (path:/tmp/pip-ZDjjOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:51:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:51:58 INFO - Running setup.py (path:/tmp/pip-bcuCts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:51:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:51:58 INFO - Running setup.py (path:/tmp/pip-punh6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:51:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:51:58 INFO - Running setup.py (path:/tmp/pip-QoXQs5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:51:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:51:58 INFO - Running setup.py (path:/tmp/pip-w6FMiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:51:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:51:58 INFO - Running setup.py (path:/tmp/pip-vMSFpN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:51:58 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:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:51:58 INFO - Running setup.py (path:/tmp/pip-ja1DJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:51:58 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:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:51:58 INFO - Running setup.py (path:/tmp/pip-rkHz9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:51:58 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:51:58 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:51:58 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:51:58 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:51:58 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:51:58 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:51:58 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:51:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:51:58 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:51:58 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:51:58 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:51:58 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:51:59 INFO - Downloading blessings-1.6.tar.gz 03:51:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:51:59 INFO - Installing collected packages: blessings 03:51:59 INFO - Running setup.py install for blessings 03:51:59 INFO - Successfully installed blessings 03:51:59 INFO - Cleaning up... 03:51:59 INFO - Return code: 0 03:51:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:51:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:51:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:52:00 INFO - Reading from file tmpfile_stdout 03:52:00 INFO - Current package versions: 03:52:00 INFO - argparse == 1.2.1 03:52:00 INFO - blessings == 1.6 03:52:00 INFO - blobuploader == 1.2.4 03:52:00 INFO - docopt == 0.6.1 03:52:00 INFO - functools32 == 3.2.3-2 03:52:00 INFO - jsonschema == 2.5.1 03:52:00 INFO - manifestparser == 1.1 03:52:00 INFO - mozInstall == 1.13 03:52:00 INFO - mozcrash == 1.0 03:52:00 INFO - mozdebug == 0.1 03:52:00 INFO - mozdevice == 0.51 03:52:00 INFO - mozfile == 1.2 03:52:00 INFO - mozhttpd == 0.7 03:52:00 INFO - mozinfo == 0.10 03:52:00 INFO - mozleak == 0.1 03:52:00 INFO - mozlog == 3.5 03:52:00 INFO - moznetwork == 0.27 03:52:00 INFO - mozprocess == 0.25 03:52:00 INFO - mozprofile == 0.28 03:52:00 INFO - mozrunner == 6.13 03:52:00 INFO - mozscreenshot == 0.1 03:52:00 INFO - mozsystemmonitor == 0.3 03:52:00 INFO - moztest == 0.8 03:52:00 INFO - mozversion == 1.4 03:52:00 INFO - psutil == 3.1.1 03:52:00 INFO - requests == 1.2.3 03:52:00 INFO - wsgiref == 0.1.2 03:52:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:52:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xab71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc84a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe25b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe28f00>, '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 0xe23ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe24050>, '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': 'd2a8c569965ab8367867b893000001a1-1502448671.107665-135259192', '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:52:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:52:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:52:00 INFO - Using env: {'DISPLAY': ':0', 03:52:00 INFO - 'HOME': '/home/cltbld', 03:52:00 INFO - 'LANG': 'en_US.UTF-8', 03:52:00 INFO - 'LANGUAGE': 'en_US:en', 03:52:00 INFO - 'LOGNAME': 'cltbld', 03:52:00 INFO - 'MAIL': '/var/mail/cltbld', 03:52:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:00 INFO - 'MOZ_NO_REMOTE': '1', 03:52:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:00 INFO - 'NO_EM_RESTART': '1', 03:52:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:00 INFO - 'PWD': '/builds/slave/test', 03:52:00 INFO - 'SHELL': '/bin/bash', 03:52:00 INFO - 'SHLVL': '1', 03:52:00 INFO - 'TERM': 'linux', 03:52:00 INFO - 'TMOUT': '86400', 03:52:00 INFO - 'USER': 'cltbld', 03:52:00 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1502448671.107665-135259192', 03:52:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:00 INFO - '_': '/tools/buildbot/bin/python'} 03:52:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:00 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:52:00 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:52:00 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:52:00 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:52:00 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:52:00 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:52:00 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:52:00 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:52:00 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:52:00 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:52:00 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:52:00 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:52:00 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:52:00 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:52:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:52:01 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:52:01 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:52:01 INFO - Installing collected packages: simplejson 03:52:01 INFO - Running setup.py install for simplejson 03:52:01 INFO - building 'simplejson._speedups' extension 03:52:01 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:52:02 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:52:02 INFO - Successfully installed simplejson 03:52:02 INFO - Cleaning up... 03:52:02 INFO - Return code: 0 03:52:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:52: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:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52: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:52:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:02 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 0xab71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc84a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe25b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe28f00>, '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 0xe23ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe24050>, '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': 'd2a8c569965ab8367867b893000001a1-1502448671.107665-135259192', '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:52:02 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:52:02 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:52:02 INFO - Using env: {'DISPLAY': ':0', 03:52:02 INFO - 'HOME': '/home/cltbld', 03:52:02 INFO - 'LANG': 'en_US.UTF-8', 03:52:02 INFO - 'LANGUAGE': 'en_US:en', 03:52:02 INFO - 'LOGNAME': 'cltbld', 03:52:02 INFO - 'MAIL': '/var/mail/cltbld', 03:52:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:02 INFO - 'MOZ_NO_REMOTE': '1', 03:52:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:02 INFO - 'NO_EM_RESTART': '1', 03:52:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:02 INFO - 'PWD': '/builds/slave/test', 03:52:02 INFO - 'SHELL': '/bin/bash', 03:52:02 INFO - 'SHLVL': '1', 03:52:02 INFO - 'TERM': 'linux', 03:52:02 INFO - 'TMOUT': '86400', 03:52:02 INFO - 'USER': 'cltbld', 03:52:02 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1502448671.107665-135259192', 03:52:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:02 INFO - '_': '/tools/buildbot/bin/python'} 03:52:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:52:02 INFO - Cleaning up... 03:52:02 INFO - Return code: 0 03:52:02 INFO - Running post-action listener: _resource_record_post_action 03:52:02 INFO - Running post-action listener: _start_resource_monitoring 03:52:02 INFO - Starting resource monitoring. 03:52:02 INFO - [mozharness: 2017-08-11 10:52:02.817218Z] Finished create-virtualenv step (success) 03:52:02 INFO - [mozharness: 2017-08-11 10:52:02.817810Z] Running install step. 03:52:02 INFO - Running pre-action listener: _resource_record_pre_action 03:52:02 INFO - Running main action method: install 03:52:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:52:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:52:03 INFO - Reading from file tmpfile_stdout 03:52:03 INFO - Detecting whether we're running mozinstall >=1.0... 03:52:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:52:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:52:03 INFO - Reading from file tmpfile_stdout 03:52:03 INFO - Output received: 03:52:03 INFO - Usage: mozinstall [options] installer 03:52:03 INFO - Options: 03:52:03 INFO - -h, --help show this help message and exit 03:52:03 INFO - -d DEST, --destination=DEST 03:52:03 INFO - Directory to install application into. [default: 03:52:03 INFO - "/builds/slave/test"] 03:52:03 INFO - --app=APP Application being installed. [default: firefox] 03:52:03 INFO - mkdir: /builds/slave/test/build/application 03:52:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:52:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:52:21 INFO - Reading from file tmpfile_stdout 03:52:21 INFO - Output received: 03:52:21 INFO - /builds/slave/test/build/application/firefox/firefox 03:52:21 INFO - Running post-action listener: _resource_record_post_action 03:52:21 INFO - [mozharness: 2017-08-11 10:52:21.154298Z] Finished install step (success) 03:52:21 INFO - [mozharness: 2017-08-11 10:52:21.154578Z] Running setup-mitmproxy step. 03:52:21 INFO - Running pre-action listener: _resource_record_pre_action 03:52:21 INFO - Running main action method: setup_mitmproxy 03:52:21 INFO - Skipping: mitmproxy is not required 03:52:21 INFO - Running post-action listener: _resource_record_post_action 03:52:21 INFO - [mozharness: 2017-08-11 10:52:21.155700Z] Finished setup-mitmproxy step (success) 03:52:21 INFO - [mozharness: 2017-08-11 10:52:21.155932Z] Running run-tests step. 03:52:21 INFO - Running pre-action listener: _resource_record_pre_action 03:52:21 INFO - Running pre-action listener: _set_gcov_prefix 03:52:21 INFO - Running main action method: run_tests 03:52:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:52:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:52:21 INFO - Python 2.7.3 03:52:21 INFO - Return code: 0 03:52:21 INFO - grabbing minidump binary from tooltool 03:52:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:21 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 0xe28f00>, '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 0xe23ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe24050>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:52:21 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:52:21 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:52:21 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:52:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:52:21 INFO - Return code: 0 03:52:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:52:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:52:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:52:21 INFO - ENV: RUST_BACKTRACE is now full 03:52:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:52:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:52:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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:52:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-043 --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:52:21 INFO - Using env: {'DISPLAY': ':0', 03:52:21 INFO - 'HOME': '/home/cltbld', 03:52:21 INFO - 'LANG': 'en_US.UTF-8', 03:52:21 INFO - 'LANGUAGE': 'en_US:en', 03:52:21 INFO - 'LOGNAME': 'cltbld', 03:52:21 INFO - 'MAIL': '/var/mail/cltbld', 03:52:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:52:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:52:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:21 INFO - 'MOZ_NO_REMOTE': '1', 03:52:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:52:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:21 INFO - 'NO_EM_RESTART': '1', 03:52:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:21 INFO - 'PWD': '/builds/slave/test', 03:52:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:52:21 INFO - 'RUST_BACKTRACE': 'full', 03:52:21 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:52:21 INFO - 'SHELL': '/bin/bash', 03:52:21 INFO - 'SHLVL': '1', 03:52:21 INFO - 'TERM': 'linux', 03:52:21 INFO - 'TMOUT': '86400', 03:52:21 INFO - 'USER': 'cltbld', 03:52:21 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1502448671.107665-135259192', 03:52:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:21 INFO - '_': '/tools/buildbot/bin/python'} 03:52:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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:52:21 INFO - mozversion application_buildid: 20170811095810 03:52:21 INFO - mozversion application_changeset: 64f5e3f40f0e7accb12cd90080e58eff0be46383 03:52:21 INFO - mozversion application_display_name: Nightly 03:52:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:52:21 INFO - mozversion application_name: Firefox 03:52:21 INFO - mozversion application_remotingname: firefox 03:52:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:52:21 INFO - mozversion application_vendor: Mozilla 03:52:21 INFO - mozversion application_version: 57.0a1 03:52:21 INFO - mozversion platform_buildid: 20170811095810 03:52:21 INFO - mozversion platform_changeset: 64f5e3f40f0e7accb12cd90080e58eff0be46383 03:52:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:52:21 INFO - mozversion platform_version: 57.0a1 03:52:21 INFO - using testdate: 1502448741 03:52:21 INFO - actual date: 1502448741 03:52:21 INFO - starting webserver on 'localhost:51750' 03:52:21 INFO - SUITE-START | Running 2 tests 03:52:21 INFO - TEST-START | dromaeo_css 03:52:21 INFO - Initialising browser for dromaeo_css test... 03:52:21 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51750/getInfo.html -profile /tmp/tmpn9jodg/profile 03:52:21 INFO - TEST-INFO | started process 26353 (/builds/slave/test/build/application/firefox/firefox http://localhost:51750/getInfo.html) 03:52:28 INFO - TEST-INFO | 26353: exit 0 03:52:28 INFO - Browser initialized. 03:52:28 INFO - Running cycle 1/1 for dromaeo_css test... 03:52:28 INFO - TEST-INFO | started process 26565 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn9jodg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:52:29 INFO - PID 26565 | 03:52:29 INFO - PID 26565 | (/builds/slave/test/build/application/firefox/firefox:26614): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:52:29 INFO - PID 26565 | 03:52:39 INFO - PID 26565 | RSS: Main: 165289984 03:52:39 INFO - PID 26565 | 03:55:38 INFO - PID 26565 | Cycle 1(1): loaded http://localhost:51750/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51750/tests/dromaeo/cssquery-ext.html) 03:55:40 INFO - PID 26565 | RSS: Main: 172584960 03:55:40 INFO - PID 26565 | 03:58:41 INFO - PID 26565 | Cycle 1(1): loaded http://localhost:51750/tests/dromaeo/cssquery-ext.html (next: http://localhost:51750/tests/dromaeo/cssquery-jquery.html) 03:58:42 INFO - PID 26565 | RSS: Main: 170168320 03:58:42 INFO - PID 26565 | 04:01:44 INFO - PID 26565 | Cycle 1(1): loaded http://localhost:51750/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51750/tests/dromaeo/cssquery-mootools.html) 04:01:44 INFO - PID 26565 | RSS: Main: 172154880 04:01:44 INFO - PID 26565 | 04:04:46 INFO - PID 26565 | Cycle 1(1): loaded http://localhost:51750/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51750/tests/dromaeo/cssquery-prototype.html) 04:04:47 INFO - PID 26565 | RSS: Main: 170717184 04:04:47 INFO - PID 26565 | 04:07:50 INFO - PID 26565 | Cycle 1(1): loaded http://localhost:51750/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51750/tests/dromaeo/cssquery-yui.html) 04:07:51 INFO - PID 26565 | RSS: Main: 173772800 04:07:51 INFO - PID 26565 | 04:10:52 INFO - PID 26565 | Cycle 1(1): loaded http://localhost:51750/tests/dromaeo/cssquery-yui.html (next: http://localhost:51750/tests/dromaeo/cssquery-dojo.html) 04:10:53 INFO - PID 26565 | RSS: Main: 174514176 04:10:53 INFO - PID 26565 | 04:10:53 INFO - PID 26565 | __start_tp_report 04:10:53 INFO - PID 26565 | _x_x_mozilla_page_load 04:10:53 INFO - PID 26565 | _x_x_mozilla_page_load_details 04:10:53 INFO - PID 26565 | |i|pagename|runs| 04:10:53 INFO - PID 26565 | |0;dojo.html;3148.055583325002;3173.2066983254185;3189.282411457422;3206.5350524173996;3212.309353489001;6108.694565271735;6265.68671566421;6274.874502509959;6300.338464461229;6307.180066591348;6103.267607887049;6230.221222347207;6235.158253635758;6256.124142620037;6300.621962682242;5675.290588676416;5696.202531645552;5697.20239166516;5709.971450142743;5802.12968054791;5775.682337471438;5786.68173250471;5795.507381872525;5810.796622118227;5816.680082595455;111.5104046248274;5583.637063590853;5670.177824215486;5802.100674395476;5804.970975145118;5597.888042239132;5603.215549823028;5642.04085305499;5716.085426331767;5752.28096487939;5622.044252477089;5638.887222255573;5698.17376480408;5711.7144142792695;5721.141828725683;6137.324894261627;6166.7224974876235;6167.105769663419;6222.315545290015;6235.314115447297;6646.93353066468;6656.101426307483;6736.191657001143;6736.797896063126;6759.391654751096;6627.900581491282;6692.59844409337;6705.295943925915;6730.663466826688;6767.492438067165;6237.812865614039;6266.216722909637;6270.3416141305415;6272.1219029335925;6272.686365681743;6820.181578210647;6948.166220053626;6968.581885086911;7004.509684322048;7014.684339204748;6567.44176744982;6581.407673309425;6598.60408375499;6672.833179170462;6678.3989440950545;6533.314002029813;6611.63636000015;6643.701033453506;6666.799996000128;6733.0237115617965;6560.442362399154;6590;6605.70274337656;6632.137822083098;6632.668366581652;6518;6608.570442921195;6665.300143484961;6686.665666716644;6699.866002679919;5385.407605163429;5411.404745477994;5435.402105768362;5455.099908515051;5476.2333273341765;4578.9542104579195;4654.790534425892;4657.69724967876;4659.906801863944;4678.95321046792;5776.826695199151;5847.532197424196;5849.473547380756;5851.063829787298;5851.736671849691;6801.625910574966;6805.761798337134;6814.216365117975;6853.040574319599;6892.965535172292;5826.096954971986;5855.502282305966;5863.120531920246;5865.442782935615;5892.94107058924;5912.46787789101;5930.584859059911;5940.762369505258;6009.579329446897;6013.579049466583;6389.105525226472;6486.4486518646445;6486.54594178403;6490.707918143695;6592.5055620828625;6650.9667451662435;6721.563098398588;6731.259561448334;6743.52795304324;6751.122354093936;6479.125318081999;6480.805575832733;6481.675916204265;6486.837829054311;6507.674616269073;6484;6519.8044058678315;6553.082568440517;6562.868742625025;6564.5076619254705;6727.058211850443;6764.4588432924265;6768.661566921733;6836.453083753188;6864.4165245954655;6495.382938620824;6512.283648798533;6519.348065193442;6610.735570577123;6634.336566343327;6413.422791948747;6429.8714025720155;6492.740290388331;6495.480361571157;6539.771108011197;6399.840003999937;6419.422251997343;6449.709763060768;6452.35476452351;6456.54804163704;6565.704543295658;6596.439302659328;6614.6361950093205;6638.867222655616;6654.4676425884845;6261.279952805486;6304.369563043659;6344.492440604833;6349.682515874096;6438.90341644885 04:10:53 INFO - PID 26565 | |1;ext.html;801.9358451323894;860.2257967828954;887.3744010472616;1167.0721776187925;1193.7612477504501;30076.84961575192;39690.80154599227;40812.97967550816;40935.59064409355;40967.79516102415;41757.58242417575;42021.36967945476;42127.36808947868;42206.366904496455;42216.57783422165;7182.712691492334;7612.086549614054;7777.144514103444;7835.804104897366;7840.803979900491;7624.428167887403;7687.346575541086;7734.187910269425;7739.380849532024;7742.109657389416;7717.729879454192;7765.844683106335;7779.416543759213;7781.455298129134;7781.727639532617;7706.036745406825;7707.96146019272;7715.922840771605;7752.612369381536;7754;7576.924230757677;7628.809279767995;7640;7640.770776876702;7642.656080476337;37605.81197093997;37895.05262368435;37954;37954.62045379538;37965.81017094925;3181.411438883814;3216.662250463691;3221.387936292097;3221.8066915985114;3223.8871639492504;30628.387432251453;30697.386052279053;30705.692943070506;30749.846250768827;30878.07365779008;4857.149998750205;4861.392325959255;4868.075065737498;4888.437829649564;4914.238293064581;190869;193140;193879;194769;194852;46875.29687054697;46908.76545617318;46916.2962555562;46929.765351173024;47157.05685886332;49239;49252.75373623109;49267.26099108516;49461.75269123631;49521.75239123782;16205.351785928666;16627.750583741254;16671.33314667424;16684.082375469465;16694.58263543397;11169.162312826571;11458.140639451907;12379.62861114168;12752.171108877894;12754.68113297175;13956.2324072177;14009.71980560383;14025.158490490603;14081.85918140826;14205.147691138565;5678.4605462480995;5751.281089863767;5813.767449302065;5831.008728516163;5854.560907931837;977.9168770654574;995.124290624246;1005.9085891807325;1008.2639673038723;1021.6526381030337;22128.33614991553;22317.330480085624;22549.887250563643;22568.435789105075;22730.20444284475;1071.908887744535;1083.8807731149568;1094.7536804218987;1099.9880110298545;1100.4057808783168;11681.88318116808;11968.82046769299;11972.221805582609;12029.09781766371;12069.517219311305;226050;227021;227582;228183;228950;52598.737006314725;52633.47366526362;52646.47353526416;52702.472975270524;52733.7363313181;1443.588577255477;1452.7239824433534;1468.5227301126963;1477.6675248069098;1481.2149560732828;21130.471738206666;22012.449688757908;27986.440271194057;28264.43471130607;28710.99511517087;51393;51643.483565163864;51741.482585175174;51792;51937.480625194774;208904;209841;210013;210311;210425;34442.82778586191;34602.307953841286;36442.63557364392;36787;36858;44517.55482445134;45389.773051134536;46802.82992925204;46868.765656172865;47116.528834711215;34034;34128.48807267943;34243;34381.48427773635;34621.826890865384;33823.83088084544;33974.830125849214;33998;34058.489122663676;34419.311613768084;36256.63743362533;36535.08662283464;36706.26587468289;36741.63258367382;36842.63157368392;32556;32783.180420489676;32807;33052;33193.502097468074;24232.636510452005;24426.389340265923;25182;25249.368765781004;25582.1832494647 04:10:53 INFO - PID 26565 | |2;jquery.html;560.792506772494;567.2002476508125;573.5526289494196;578.2656026845905;580.2717589425273;22088.668669969964;22764.54470910581;22772.31683049507;22774.65838012431;22808.31575052747;24365.512689746196;26654.33364165897;26767.86616066922;26816.195514134557;26898.327541811464;6459.031145328203;6565.671716414184;6585.769498067569;6593.044008618747;6607.174103237096;6145.108959200936;6477.481801455896;6512.772052978146;6524.184476940382;6588.308227636101;6452.032195170738;6471.870562588769;6481;6489.5781774184525;6496.447801936841;6451.58064725796;6457.612543247396;6462.32145624712;6465.062565927961;6467.74129034838;6012.368701286389;6026.9095963560585;6027.60820546663;6036.124761909542;6036.96981515094;29167.124986250234;30122.493875306365;30354.392912141855;30498.170109793482;30742.077737667907;1927.6241132979076;1965.4202010406964;1996.331229038274;1999.8800071995727;2001.3295545991964;18882.244710211577;19580.118894649633;19618.70571941422;19624.215031398726;19663.60672786536;2269.296518079401;2309.226409152936;2354.5761762882676;2360.7167139943317;2449.7182823975295;138541;140824;141717.29141354226;142000.28999854936;142423;14287.357068931922;14691.85308146905;14920.70158596822;15239.542813715607;15242.314095865713;23392.298231053097;23482.178123765585;23494;23520.529589408117;23553.528929421314;9830.459324737065;9947.751306217402;10058.446785426871;10211.897881021094;10213.131883789962;7559.886601700869;9241.58412871409;9327.673531426368;9352.298577606707;9361.953190234006;7926.643301051467;9092.227160691284;9107.81784364309;9171.63313467454;9257.259419246444;2650.430157516105;2654.9601755973677;2771.473420050184;2773.6671599407796;2872.7558157556423;944.3153713557616;967.9758006049764;976.32633482898;982.8673129127476;984;19779.10994005273;20224;20237.392878213675;20302.18791248363;20711.275105371238;1028.8199565076231;1035.0839507036176;1036.3367444835312;1037.2894567221326;1049.1030169205371;11090.5563777448;13385.73228535424;14320.928395358165;14352.784708229385;14621.707565848836;475030;477052;477594;486279;499361;118707;119547;120322;121989;122371.38814305872;1260.0612543655036;1261.3377976562379;1289.8258735070644;1295.6784080238103;1303.9217646941213;21348.35954921355;21503.892480537495;21575.784242157377;21650.8917455418;21809.01859416362;56049.15926261028;56442.435575643714;56983.71508142599;57715.711421444306;58401.415985839594;72344.63827680828;73286.26713732794;73613;73619.63190184014;74350.62824685842;12215.938920305342;12852.421641025989;14263.286835658384;14312.427502899767;14900.478483253035;23522.29433117009;23559.293221203392;23615.763842361357;25052.874735626207;25247.87376063108;18594.721079183553;19112.713309300092;19417.12622931943;19429.61140777148;19544.804551954297;17989.190486428404;17998.190081446628;18080.276788928822;18107.637847242717;18234.908825455786;19794.505137371103;19856.50358741043;19933.302334418226;20067.69898451495;20302.187912483925;14793.778093328394;14908.85091149118;14922.701545969237;15017.924910375816;15133.243337833284;18704.719429208846;18887.90556047211;18939.242430302635;19047.619047619246;19201.807981920003 04:10:53 INFO - PID 26565 | |3;mootools.html;1327.1373607155347;1368.4799776085085;1372.5607805502236;1384.1072508232185;1384.8753612174908;11679.065674746022;12324.938375308133;12340.25958442494;14541.272936353167;15075.396984120622;14430.20633865137;14715.632109197275;14722.63193420165;14731.926340368283;14747;2486.825922185448;2570.858602776851;2599.3241757143182;2606.205107442239;2638.023931145479;2707.6615423072117;2767.529519981608;2771.1547977866744;2773.5978283149034;2774.9306267343377;2697.757201851833;2733.289344770354;2761.2130542795308;2763.6821765496925;2776.444711057786;2596.143272719998;2600.0249906285144;2614.49017441598;2640.973590264092;2687.932801679954;2603.6615240018677;2611.856347900865;2629.855357955312;2630.18464276075;2635.143578337048;13920.791188132187;14266.572002839932;14501.564953051426;14510.854891451056;14520.491782787658;7702.268284512962;8027.558484283362;8048.476849004796;8054.476459030145;8057.194280571955;4930.975345123287;4940.3330550375595;5024.748762561857;5102.974485127587;5117.667351622133;1855.1188185611861;1876.6340563590106;1890.2911408221917;1917.8849269043762;1941.6990366493217;23963.041478340845;23965.880170599034;24095.87952060246;24119.87940060306;24194.15320463793;6337.841553961188;6601.768938087144;6767.052612634235;6773.729050837911;6852.554583952027;16367.345306187857;16413.097279649734;16431.753523697153;16450.75323870143;16469.094199819127;7648.579328137006;7784.41616878725;7792.493487923267;7794.10367807698;7797.844043119106;5811.912821307684;5988.490978266809;6866.34769696878;6918.654067296615;7174.354308112295;5224.791008359699;5274.077036518594;5340.946590534123;5394.190871369247;5406.351237851483;1485.7474229381032;1519.8176218853587;1552.7748476471074;1553.9300731466885;1566.6788308396751;910.39003867409;925.1165137293868;926.416357694648;929.7350255177242;931.9934470771686;7357.705691772377;7372.115346158495;7386.741464048732;7427.071616047994;7440.516366436273;718.4647437658873;741.1809950005166;985.9408435493893;1005.7837564923576;1014.6043043213152;4946.332245146859;4973.676711013773;5164.870878227999;5241.554467870197;5344.8663783404945;19376.903115484332;19516.414507564798;19810;20082.497937551678;20781.792182078287;19923.302684405975;20134.597308053755;20271.391858244275;20289.898550507154;20308;11168.888311116947;11189.944050279697;11317.71705707364;11329.773404532029;11379.317240965569;8082.191780822106;8358.540280284642;8597.957010214908;8749.781255468664;8778.91221087781;17179.742303865703;17705.64588708193;17753;18057.458276251735;18058.819411805714;17641.735373969143;18042.72935905936;18240.17919193666;18298.817011829713;18302.26790928401;9812.264080194156;11603.709907252387;11766.411679416165;11875.940620296844;11934.701632458911;11492.253003554742;13165.407556659782;13552.525661601796;13555.457781689016;13576.524821631196;10809.297395669257;10838.566457341618;10980.286281391684;11056;11254.94372528132;10559.891211422997;10689.09142722846;10795.676129716121;10894.67315980522;11078.169137314895;9189.448633081769;9362.391444556082;9548.236141108555;9571.808563828545;9577.473238971645;6689.331066893272;7125;7177.964110179416;7210.603416812126;7220.133583969957;6923.099997000358;7101.467389945671;7133.928660713326;7162.964185179041;7231.2768723127265 04:10:53 INFO - PID 26565 | |4;prototype.html;504.4287045852167;516.7209706758351;517.3119750731528;521.0724909660803;536.4474591171092;6084.756609735606;6085.421884920926;6103.938960610403;6176;6183.134361189437;5974.372690867462;6023.939760602393;6047.727852246649;6087.3303936566945;6091.9287442269615;5021.5688528769215;5051.494850514938;5075.111855425304;5085.491450854922;5085.847424577269;4690.530946905316;4890.535399137094;4987.451380348159;4996.825111121111;5018.84943451697;4795;4844.491328410519;4850.102730994778;4870.050340183666;4875.488073752258;4722.645801564862;4827.117424204563;4838.588719958808;4895.437024742147;4898.706077635354;4343.261645520269;4344.304911214223;4382.189294980439;4383.320585309282;4388.890277743082;5870.178175055496;5969.611975221596;5972.581919265654;5987.036416973626;6005.399460054004;5573.442655734394;5580.274564306655;5586.441355864422;5644.322681278232;5656.0101982152955;6378.298387177407;6421.871562568723;6450.903236451457;6482.573833756566;6502.707378167994;4729.810807567693;4784.473707892129;4788;4799.208130658437;4842.370491836074;6449.774257900951;6596.901046484307;6598.967005164944;6715.496337774637;6789.321067893171;4870.09903167915;4881.707097574157;4899.436564795023;4913.729744863996;4922.827701030446;4865.829695960624;4914.606831453547;4951.331570238044;4980.377452818398;5028.974855125774;5563.693996830132;5603.887922241533;5613.578981576398;5637.436256374412;5645.435456454322;6471.838204044842;6477.77327793525;6496.577722448026;6505.251896032017;6508.60948343101;1716.5794380376888;1717.0511469481978;1744.97382539262;1761.9207135678926;1765.6203916158088;1159.588346137126;1197.4491733802374;1210.933398663082;1217.817327400897;1225.8161275808523;5579.38626751057;5592.161175823578;5669.716514174274;5675.858103547362;5709.9714501427225;6469.159009328757;6525.249596296487;6548.312427195171;6574.408303252731;6591.802245932629;5567.582431317667;5587.720613969285;5605.523530499871;5664.20701101846;5703.116017017369;3427.485877118452;3470.913227169341;3485;3490.616032236452;3524.1189702574356;6287.245530536274;6346.174997250328;6375.808725738235;6408.1349017881985;6441.58129721576;6681.164854393201;6739.932600674028;6754.45964322853;6768.544762875907;6791.185057792997;6274.686265686789;6282.403171698681;6332.208473940757;6422.74309027643;6450.0647406125845;6464.515161362822;6470.288268290578;6472.514561407819;6582.934170658232;6643.800685979429;6438.517111216771;6444.355564443518;6452.387023232785;6575.027491752359;6611.30581288977;5800.637443283531;6344.651044192614;6376.776812811529;6406.935930640634;6424.453921416732;4946.961138161027;4955.975220123876;4956.132676781621;5292.867678307919;5443.428440013741;6387.137736405712;6545.5090868184125;6615.702293396713;6671.664917278914;6699.598024118373;6415.486761059011;6456.386643268882;6467.320931302145;6515.218173819172;6526.379993900572;6475.708593113415;6488.708008139551;6493.8701225976165;6510.414062734377;6542.5420220586;6422.233885681475;6424.839379015562;6440.903386449113;6452.741890324334;6468.514861385321;6403.167588213502;6414.903776443451;6500.122483464672;6504.902426463702;6547.901781473377;6258.561900666909;6260.40526150015;6293.779717710041;6314.526410519321;6365.936340636719 04:10:53 INFO - PID 26565 | |5;yui.html;913.7167478081795;914.8993610702821;934.878465799446;937.2174234514181;947.5451783144093;17117.48647540574;17751.733723994133;17759;17795;19737.506562335948;21391.465213369673;21730;21923;21948;21951.231706890263;1014.2849291249652;1033.9172866170725;1035.5340096956363;1039;1040.921930855189;1010.0555980158575;1039.4958445154093;1044.310754901765;1048.051513380392;1054.7679510507676;1079.5897558927597;1081.1891081688734;1081.621432498627;1081.983770243447;1082.5453309609982;1077.3966578715945;1079.2283517285139;1079.740862193072;1080.2384319055047;1080.254624309224;791.8218400859818;792.8652129138061;792.8771040488676;792.8929594504725;792.9643166057541;17645.7353139703;18114.094295285184;18250.269989200417;18277.54306142344;18347.16528347168;20976.790232097635;21444.463888402915;21895.67156492654;21937.890310548344;22152;15989;16974.066426346548;17144.485665430057;17148.571285717833;17159.142042897805;3567.161716996504;3586.7309951753464;3601.2797440512004;3611.368010598135;3617.4031284838234;124950.33236238758;124957;126878.99999999908;129139;129391;16670.249838757285;16841.831581684026;17211.225494852762;17286.22212000463;17337.65324693499;30784.53823192609;30928;31610.525842112387;31689.366212675617;31746.523802142987;7286.089238845145;7750.3024727773645;7816.140224575292;7905.604719763989;8374;4161.542230354658;4285.100128972888;4290.699651024461;4315.870523884289;4331.7834108294455;5339.626226164131;5391.7304134793885;5438.374586922476;5511.118221084607;5511.944880551223;1050.3540322701483;1070.1813112968584;1074.0762943868267;1084.9132069434427;1091.1816137896578;681.2540268406087;703.0368395298372;705.9576425414389;707.8938159276047;712.0920825946855;11935.880641193651;12065.517379304905;12344.876551234373;12562.81155782664;13637.454501819817;698.0645934447864;700.961447120403;701.5089437393844;708.450950513346;716.7563028570311;5310.575153987672;5314.096603577401;5343;5345.625806193607;5452.836414907559;108216;111145;113589;115020;115964;99535;99721.50139249257;101177.98822011685;102974;107206.46396767967;87715.56142219248;87918.56040719755;88642;90426;92679.53660231656;10198.745031374276;10311.22665800083;10354.275200735876;10517.263791534519;12463.688407789878;39029.41455878107;40121.39817902676;40152;41091.794541027106;41413.792931035154;70857.29142708507;72380.27619723736;73693.26306736864;74220.62889685517;75457;17676.91161544184;18648.16083276283;19444;19797;19811.504712382306;16968.321267149175;17457.56356091108;17597.12014399249;17735.733963990293;20950.47623809417;17329.220185091952;18771.061446927324;19797.30709425163;19804.60390792147;19989.60020799605;16623.418180363627;16659.167041647626;16866.831331686528;16921.323147073977;17006.914965425094;16801;17233.655326893644;17338.959662420297;17367.218475168902;17417.912910435367;13747.656308592364;13808.792868107188;14149.575512734635;14193.503227386991;14358.784618230526;9081.228095611947;10765.138788897026;14786.482473113389;14939;14999.400023998918 04:10:53 INFO - PID 26565 | __end_tp_report 04:10:53 INFO - PID 26565 | __start_cc_report 04:10:53 INFO - PID 26565 | _x_x_mozilla_cycle_collect,384 04:10:53 INFO - PID 26565 | __end_cc_report 04:10:53 INFO - PID 26565 | __startTimestamp1502449853042__endTimestamp 04:10:53 INFO - PID 26565 | 04:10:53 INFO - PID 26565 | ------- Summary: start ------- 04:10:53 INFO - PID 26565 | Number of tests: 6 04:10:53 INFO - PID 26565 | 04:10:53 INFO - PID 26565 | [#0] dojo.html Cycles:165 Average:6134.35 Median:6419.42 stddev:863.16 (13.4%) stddev-sans-first:833.41 04:10:53 INFO - PID 26565 | Values: 3148.1 3173.2 3189.3 3206.5 3212.3 6108.7 6265.7 6274.9 6300.3 6307.2 6103.3 6230.2 6235.2 6256.1 6300.6 5675.3 5696.2 5697.2 5710.0 5802.1 5775.7 5786.7 5795.5 5810.8 5816.7 111.5 5583.6 5670.2 5802.1 5805.0 5597.9 5603.2 5642.0 5716.1 5752.3 5622.0 5638.9 5698.2 5711.7 5721.1 6137.3 6166.7 6167.1 6222.3 6235.3 6646.9 6656.1 6736.2 6736.8 6759.4 6627.9 6692.6 6705.3 6730.7 6767.5 6237.8 6266.2 6270.3 6272.1 6272.7 6820.2 6948.2 6968.6 7004.5 7014.7 6567.4 6581.4 6598.6 6672.8 6678.4 6533.3 6611.6 6643.7 6666.8 6733.0 6560.4 6590.0 6605.7 6632.1 6632.7 6518.0 6608.6 6665.3 6686.7 6699.9 5385.4 5411.4 5435.4 5455.1 5476.2 4579.0 4654.8 4657.7 4659.9 4679.0 5776.8 5847.5 5849.5 5851.1 5851.7 6801.6 6805.8 6814.2 6853.0 6893.0 5826.1 5855.5 5863.1 5865.4 5892.9 5912.5 5930.6 5940.8 6009.6 6013.6 6389.1 6486.4 6486.5 6490.7 6592.5 6651.0 6721.6 6731.3 6743.5 6751.1 6479.1 6480.8 6481.7 6486.8 6507.7 6484.0 6519.8 6553.1 6562.9 6564.5 6727.1 6764.5 6768.7 6836.5 6864.4 6495.4 6512.3 6519.3 6610.7 6634.3 6413.4 6429.9 6492.7 6495.5 6539.8 6399.8 6419.4 6449.7 6452.4 6456.5 6565.7 6596.4 6614.6 6638.9 6654.5 6261.3 6304.4 6344.5 6349.7 6438.9 04:10:53 INFO - PID 26565 | 04:10:53 INFO - PID 26565 | [#1] ext.html Cycles:180 Average:38477.15 Median:34522.57 stddev:54624.19 (158.2%) stddev-sans-first:54704.17 04:10:53 INFO - PID 26565 | Values: 801.9 860.2 887.4 1167.1 1193.8 30076.8 39690.8 40813.0 40935.6 40967.8 41757.6 42021.4 42127.4 42206.4 42216.6 7182.7 7612.1 7777.1 7835.8 7840.8 7624.4 7687.3 7734.2 7739.4 7742.1 7717.7 7765.8 7779.4 7781.5 7781.7 7706.0 7708.0 7715.9 7752.6 7754.0 7576.9 7628.8 7640.0 7640.8 7642.7 37605.8 37895.1 37954.0 37954.6 37965.8 3181.4 3216.7 3221.4 3221.8 3223.9 30628.4 30697.4 30705.7 30749.8 30878.1 4857.1 4861.4 4868.1 4888.4 4914.2 190869.0 193140.0 193879.0 194769.0 194852.0 46875.3 46908.8 46916.3 46929.8 47157.1 49239.0 49252.8 49267.3 49461.8 49521.8 16205.4 16627.8 16671.3 16684.1 16694.6 11169.2 11458.1 12379.6 12752.2 12754.7 13956.2 14009.7 14025.2 14081.9 14205.1 5678.5 5751.3 5813.8 5831.0 5854.6 977.9 995.1 1005.9 1008.3 1021.7 22128.3 22317.3 22549.9 22568.4 22730.2 1071.9 1083.9 1094.8 1100.0 1100.4 11681.9 11968.8 11972.2 12029.1 12069.5 226050.0 227021.0 227582.0 228183.0 228950.0 52598.7 52633.5 52646.5 52702.5 52733.7 1443.6 1452.7 1468.5 1477.7 1481.2 21130.5 22012.4 27986.4 28264.4 28711.0 51393.0 51643.5 51741.5 51792.0 51937.5 208904.0 209841.0 210013.0 210311.0 210425.0 34442.8 34602.3 36442.6 36787.0 36858.0 44517.6 45389.8 46802.8 46868.8 47116.5 34034.0 34128.5 34243.0 34381.5 34621.8 33823.8 33974.8 33998.0 34058.5 34419.3 36256.6 36535.1 36706.3 36741.6 36842.6 32556.0 32783.2 32807.0 33052.0 33193.5 24232.6 24426.4 25182.0 25249.4 25582.2 04:10:53 INFO - PID 26565 | 04:10:53 INFO - PID 26565 | [#2] jquery.html Cycles:180 Average:35211.42 Median:23437.24 stddev:81737.58 (348.8%) stddev-sans-first:81925.47 04:10:53 INFO - PID 26565 | Values: 560.8 567.2 573.6 578.3 580.3 22088.7 22764.5 22772.3 22774.7 22808.3 24365.5 26654.3 26767.9 26816.2 26898.3 6459.0 6565.7 6585.8 6593.0 6607.2 6145.1 6477.5 6512.8 6524.2 6588.3 6452.0 6471.9 6481.0 6489.6 6496.4 6451.6 6457.6 6462.3 6465.1 6467.7 6012.4 6026.9 6027.6 6036.1 6037.0 29167.1 30122.5 30354.4 30498.2 30742.1 1927.6 1965.4 1996.3 1999.9 2001.3 18882.2 19580.1 19618.7 19624.2 19663.6 2269.3 2309.2 2354.6 2360.7 2449.7 138541.0 140824.0 141717.3 142000.3 142423.0 14287.4 14691.9 14920.7 15239.5 15242.3 23392.3 23482.2 23494.0 23520.5 23553.5 9830.5 9947.8 10058.4 10211.9 10213.1 7559.9 9241.6 9327.7 9352.3 9362.0 7926.6 9092.2 9107.8 9171.6 9257.3 2650.4 2655.0 2771.5 2773.7 2872.8 944.3 968.0 976.3 982.9 984.0 19779.1 20224.0 20237.4 20302.2 20711.3 1028.8 1035.1 1036.3 1037.3 1049.1 11090.6 13385.7 14320.9 14352.8 14621.7 475030.0 477052.0 477594.0 486279.0 499361.0 118707.0 119547.0 120322.0 121989.0 122371.4 1260.1 1261.3 1289.8 1295.7 1303.9 21348.4 21503.9 21575.8 21650.9 21809.0 56049.2 56442.4 56983.7 57715.7 58401.4 72344.6 73286.3 73613.0 73619.6 74350.6 12215.9 12852.4 14263.3 14312.4 14900.5 23522.3 23559.3 23615.8 25052.9 25247.9 18594.7 19112.7 19417.1 19429.6 19544.8 17989.2 17998.2 18080.3 18107.6 18234.9 19794.5 19856.5 19933.3 20067.7 20302.2 14793.8 14908.9 14922.7 15017.9 15133.2 18704.7 18887.9 18939.2 19047.6 19201.8 04:10:53 INFO - PID 26565 | 04:10:53 INFO - PID 26565 | [#3] mootools.html Cycles:180 Average:8892.91 Median:2601.84 stddev:6179.60 (237.5%) stddev-sans-first:6170.78 04:10:53 INFO - PID 26565 | Values: 1327.1 1368.5 1372.6 1384.1 1384.9 11679.1 12324.9 12340.3 14541.3 15075.4 14430.2 14715.6 14722.6 14731.9 14747.0 2486.8 2570.9 2599.3 2606.2 2638.0 2707.7 2767.5 2771.2 2773.6 2774.9 2697.8 2733.3 2761.2 2763.7 2776.4 2596.1 2600.0 2614.5 2641.0 2687.9 2603.7 2611.9 2629.9 2630.2 2635.1 13920.8 14266.6 14501.6 14510.9 14520.5 7702.3 8027.6 8048.5 8054.5 8057.2 4931.0 4940.3 5024.7 5103.0 5117.7 1855.1 1876.6 1890.3 1917.9 1941.7 23963.0 23965.9 24095.9 24119.9 24194.2 6337.8 6601.8 6767.1 6773.7 6852.6 16367.3 16413.1 16431.8 16450.8 16469.1 7648.6 7784.4 7792.5 7794.1 7797.8 5811.9 5988.5 6866.3 6918.7 7174.4 5224.8 5274.1 5340.9 5394.2 5406.4 1485.7 1519.8 1552.8 1553.9 1566.7 910.4 925.1 926.4 929.7 932.0 7357.7 7372.1 7386.7 7427.1 7440.5 718.5 741.2 985.9 1005.8 1014.6 4946.3 4973.7 5164.9 5241.6 5344.9 19376.9 19516.4 19810.0 20082.5 20781.8 19923.3 20134.6 20271.4 20289.9 20308.0 11168.9 11189.9 11317.7 11329.8 11379.3 8082.2 8358.5 8598.0 8749.8 8778.9 17179.7 17705.6 17753.0 18057.5 18058.8 17641.7 18042.7 18240.2 18298.8 18302.3 9812.3 11603.7 11766.4 11875.9 11934.7 11492.3 13165.4 13552.5 13555.5 13576.5 10809.3 10838.6 10980.3 11056.0 11254.9 10559.9 10689.1 10795.7 10894.7 11078.2 9189.4 9362.4 9548.2 9571.8 9577.5 6689.3 7125.0 7178.0 7210.6 7220.1 6923.1 7101.5 7133.9 7163.0 7231.3 04:10:53 INFO - PID 26565 | 04:10:53 INFO - PID 26565 | [#4] prototype.html Cycles:180 Average:5417.07 Median:5996.22 stddev:1512.95 (25.2%) stddev-sans-first:1471.58 04:10:53 INFO - PID 26565 | Values: 504.4 516.7 517.3 521.1 536.4 6084.8 6085.4 6103.9 6176.0 6183.1 5974.4 6023.9 6047.7 6087.3 6091.9 5021.6 5051.5 5075.1 5085.5 5085.8 4690.5 4890.5 4987.5 4996.8 5018.8 4795.0 4844.5 4850.1 4870.1 4875.5 4722.6 4827.1 4838.6 4895.4 4898.7 4343.3 4344.3 4382.2 4383.3 4388.9 5870.2 5969.6 5972.6 5987.0 6005.4 5573.4 5580.3 5586.4 5644.3 5656.0 6378.3 6421.9 6450.9 6482.6 6502.7 4729.8 4784.5 4788.0 4799.2 4842.4 6449.8 6596.9 6599.0 6715.5 6789.3 4870.1 4881.7 4899.4 4913.7 4922.8 4865.8 4914.6 4951.3 4980.4 5029.0 5563.7 5603.9 5613.6 5637.4 5645.4 6471.8 6477.8 6496.6 6505.3 6508.6 1716.6 1717.1 1745.0 1761.9 1765.6 1159.6 1197.4 1210.9 1217.8 1225.8 5579.4 5592.2 5669.7 5675.9 5710.0 6469.2 6525.2 6548.3 6574.4 6591.8 5567.6 5587.7 5605.5 5664.2 5703.1 3427.5 3470.9 3485.0 3490.6 3524.1 6287.2 6346.2 6375.8 6408.1 6441.6 6681.2 6739.9 6754.5 6768.5 6791.2 6274.7 6282.4 6332.2 6422.7 6450.1 6464.5 6470.3 6472.5 6582.9 6643.8 6438.5 6444.4 6452.4 6575.0 6611.3 5800.6 6344.7 6376.8 6406.9 6424.5 4947.0 4956.0 4956.1 5292.9 5443.4 6387.1 6545.5 6615.7 6671.7 6699.6 6415.5 6456.4 6467.3 6515.2 6526.4 6475.7 6488.7 6493.9 6510.4 6542.5 6422.2 6424.8 6440.9 6452.7 6468.5 6403.2 6414.9 6500.1 6504.9 6547.9 6258.6 6260.4 6293.8 6314.5 6365.9 04:10:53 INFO - PID 26565 | 04:10:53 INFO - PID 26565 | [#5] yui.html Cycles:180 Average:24045.61 Median:18312.35 stddev:33057.76 (180.5%) stddev-sans-first:33104.86 04:10:53 INFO - PID 26565 | Values: 913.7 914.9 934.9 937.2 947.5 17117.5 17751.7 17759.0 17795.0 19737.5 21391.5 21730.0 21923.0 21948.0 21951.2 1014.3 1033.9 1035.5 1039.0 1040.9 1010.1 1039.5 1044.3 1048.1 1054.8 1079.6 1081.2 1081.6 1082.0 1082.5 1077.4 1079.2 1079.7 1080.2 1080.3 791.8 792.9 792.9 792.9 793.0 17645.7 18114.1 18250.3 18277.5 18347.2 20976.8 21444.5 21895.7 21937.9 22152.0 15989.0 16974.1 17144.5 17148.6 17159.1 3567.2 3586.7 3601.3 3611.4 3617.4 124950.3 124957.0 126879.0 129139.0 129391.0 16670.2 16841.8 17211.2 17286.2 17337.7 30784.5 30928.0 31610.5 31689.4 31746.5 7286.1 7750.3 7816.1 7905.6 8374.0 4161.5 4285.1 4290.7 4315.9 4331.8 5339.6 5391.7 5438.4 5511.1 5511.9 1050.4 1070.2 1074.1 1084.9 1091.2 681.3 703.0 706.0 707.9 712.1 11935.9 12065.5 12344.9 12562.8 13637.5 698.1 701.0 701.5 708.5 716.8 5310.6 5314.1 5343.0 5345.6 5452.8 108216.0 111145.0 113589.0 115020.0 115964.0 99535.0 99721.5 101178.0 102974.0 107206.5 87715.6 87918.6 88642.0 90426.0 92679.5 10198.7 10311.2 10354.3 10517.3 12463.7 39029.4 40121.4 40152.0 41091.8 41413.8 70857.3 72380.3 73693.3 74220.6 75457.0 17676.9 18648.2 19444.0 19797.0 19811.5 16968.3 17457.6 17597.1 17735.7 20950.5 17329.2 18771.1 19797.3 19804.6 19989.6 16623.4 16659.2 16866.8 16921.3 17006.9 16801.0 17233.7 17339.0 17367.2 17417.9 13747.7 13808.8 14149.6 14193.5 14358.8 9081.2 10765.1 14786.5 14939.0 14999.4 04:10:53 INFO - PID 26565 | -------- Summary: end -------- 04:10:53 INFO - PID 26565 | 04:10:53 INFO - TEST-INFO | 26565: exit 0 04:10:53 INFO - TEST-OK | dromaeo_css | took 1112242ms 04:10:53 INFO - TEST-START | kraken 04:10:53 INFO - Initialising browser for kraken test... 04:10:53 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51750/getInfo.html -profile /tmp/tmpJwB3Bd/profile 04:10:53 INFO - TEST-INFO | started process 26929 (/builds/slave/test/build/application/firefox/firefox http://localhost:51750/getInfo.html) 04:10:59 INFO - TEST-INFO | 26929: exit 0 04:10:59 INFO - Browser initialized. 04:10:59 INFO - Running cycle 1/1 for kraken test... 04:10:59 INFO - TEST-INFO | started process 27143 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJwB3Bd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:11:00 INFO - PID 27143 | 04:11:00 INFO - PID 27143 | (/builds/slave/test/build/application/firefox/firefox:27191): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:11:00 INFO - PID 27143 | 04:11:11 INFO - PID 27143 | RSS: Main: 165675008 04:11:11 INFO - PID 27143 | 04:11:13 INFO - PID 27143 | Cycle 1(1): loaded http://localhost:51750/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51750/tests/kraken/driver.html?testName=audio-beat-detection) 04:11:14 INFO - PID 27143 | RSS: Main: 172863488 04:11:14 INFO - PID 27143 | 04:11:17 INFO - PID 27143 | Cycle 1(1): loaded http://localhost:51750/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51750/tests/kraken/driver.html?testName=audio-dft) 04:11:18 INFO - PID 27143 | RSS: Main: 172883968 04:11:18 INFO - PID 27143 | 04:11:21 INFO - PID 27143 | Cycle 1(1): loaded http://localhost:51750/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51750/tests/kraken/driver.html?testName=audio-fft) 04:11:21 INFO - PID 27143 | RSS: Main: 166891520 04:11:21 INFO - PID 27143 | 04:11:23 INFO - PID 27143 | Cycle 1(1): loaded http://localhost:51750/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51750/tests/kraken/driver.html?testName=audio-oscillator) 04:11:24 INFO - PID 27143 | RSS: Main: 167403520 04:11:24 INFO - PID 27143 | 04:11:26 INFO - PID 27143 | Cycle 1(1): loaded http://localhost:51750/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51750/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:11:27 INFO - PID 27143 | RSS: Main: 167550976 04:11:27 INFO - PID 27143 | 04:11:30 INFO - PID 27143 | Cycle 1(1): loaded http://localhost:51750/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51750/tests/kraken/driver.html?testName=imaging-darkroom) 04:11:30 INFO - PID 27143 | RSS: Main: 170233856 04:11:30 INFO - PID 27143 | 04:11:34 INFO - PID 27143 | Cycle 1(1): loaded http://localhost:51750/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51750/tests/kraken/driver.html?testName=imaging-desaturate) 04:11:35 INFO - PID 27143 | RSS: Main: 170848256 04:11:35 INFO - PID 27143 | 04:11:37 INFO - PID 27143 | Cycle 1(1): loaded http://localhost:51750/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51750/tests/kraken/driver.html?testName=json-parse-financial) 04:11:38 INFO - PID 27143 | RSS: Main: 171040768 04:11:38 INFO - PID 27143 | 04:11:40 INFO - PID 27143 | Cycle 1(1): loaded http://localhost:51750/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51750/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:11:40 INFO - PID 27143 | RSS: Main: 171765760 04:11:40 INFO - PID 27143 | 04:11:42 INFO - PID 27143 | Cycle 1(1): loaded http://localhost:51750/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51750/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:11:43 INFO - PID 27143 | RSS: Main: 171155456 04:11:43 INFO - PID 27143 | 04:11:45 INFO - PID 27143 | Cycle 1(1): loaded http://localhost:51750/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51750/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:11:45 INFO - PID 27143 | RSS: Main: 171372544 04:11:45 INFO - PID 27143 | 04:11:48 INFO - PID 27143 | Cycle 1(1): loaded http://localhost:51750/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51750/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:11:49 INFO - PID 27143 | RSS: Main: 171761664 04:11:49 INFO - PID 27143 | 04:11:52 INFO - PID 27143 | Cycle 1(1): loaded http://localhost:51750/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51750/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:11:53 INFO - PID 27143 | RSS: Main: 171814912 04:11:53 INFO - PID 27143 | 04:11:54 INFO - PID 27143 | Cycle 1(1): loaded http://localhost:51750/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51750/tests/kraken/driver.html?testName=ai-astar) 04:11:55 INFO - PID 27143 | RSS: Main: 173293568 04:11:55 INFO - PID 27143 | 04:11:55 INFO - PID 27143 | __start_tp_report 04:11:55 INFO - PID 27143 | _x_x_mozilla_page_load 04:11:55 INFO - PID 27143 | _x_x_mozilla_page_load_details 04:11:55 INFO - PID 27143 | |i|pagename|runs| 04:11:55 INFO - PID 27143 | |0;ai-astar;98;107;100;107;108;109;109;98;108;108 04:11:55 INFO - PID 27143 | |1;audio-beat-detection;139;116;151;184;119;144;150;120;168;117 04:11:55 INFO - PID 27143 | |2;audio-dft;165;163;164;163;164;162;164;168;167;163 04:11:55 INFO - PID 27143 | |3;audio-fft;74;76;75;181;76;74;76;91;98;77 04:11:55 INFO - PID 27143 | |4;audio-oscillator;79;79;137;79;79;79;128;79;79;124 04:11:55 INFO - PID 27143 | |5;imaging-gaussian-blur;114;114;114;114;116;114;114;115;114;114 04:11:55 INFO - PID 27143 | |6;imaging-darkroom;150;150;151;153;151;150;151;150;151;150 04:11:55 INFO - PID 27143 | |7;imaging-desaturate;94;95;94;94;94;93;94;94;94;95 04:11:55 INFO - PID 27143 | |8;json-parse-financial;54;54;53;53;56;54;53;54;54;54 04:11:55 INFO - PID 27143 | |9;json-stringify-tinderbox;54;55;55;56;55;55;55;56;55;55 04:11:55 INFO - PID 27143 | |10;stanford-crypto-aes;81;88;81;79;78;77;78;77;80;78 04:11:55 INFO - PID 27143 | |11;stanford-crypto-ccm;129;130;127;135;131;135;126;121;123;175 04:11:55 INFO - PID 27143 | |12;stanford-crypto-pbkdf2;173;178;179;185;178;171;172;173;186;172 04:11:55 INFO - PID 27143 | |13;stanford-crypto-sha256-iterative;73;69;66;67;68;67;66;66;67;67 04:11:55 INFO - PID 27143 | __end_tp_report 04:11:55 INFO - PID 27143 | __start_cc_report 04:11:55 INFO - PID 27143 | _x_x_mozilla_cycle_collect,992 04:11:55 INFO - PID 27143 | __end_cc_report 04:11:55 INFO - PID 27143 | __startTimestamp1502449915026__endTimestamp 04:11:55 INFO - PID 27143 | 04:11:55 INFO - PID 27143 | ------- Summary: start ------- 04:11:55 INFO - PID 27143 | Number of tests: 14 04:11:55 INFO - PID 27143 | 04:11:55 INFO - PID 27143 | [#0] ai-astar Cycles:10 Average:105.20 Median:108.50 stddev:4.59 (4.2%) stddev-sans-first:4.06 04:11:55 INFO - PID 27143 | Values: 98.0 107.0 100.0 107.0 108.0 109.0 109.0 98.0 108.0 108.0 04:11:55 INFO - PID 27143 | 04:11:55 INFO - PID 27143 | [#1] audio-beat-detection Cycles:10 Average:140.80 Median:147.00 stddev:23.33 (15.9%) stddev-sans-first:24.73 04:11:55 INFO - PID 27143 | Values: 139.0 116.0 151.0 184.0 119.0 144.0 150.0 120.0 168.0 117.0 04:11:55 INFO - PID 27143 | 04:11:55 INFO - PID 27143 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.00 stddev:1.89 (1.2%) stddev-sans-first:1.99 04:11:55 INFO - PID 27143 | Values: 165.0 163.0 164.0 163.0 164.0 162.0 164.0 168.0 167.0 163.0 04:11:55 INFO - PID 27143 | 04:11:55 INFO - PID 27143 | [#3] audio-fft Cycles:10 Average:89.80 Median:76.00 stddev:33.06 (43.5%) stddev-sans-first:34.57 04:11:55 INFO - PID 27143 | Values: 74.0 76.0 75.0 181.0 76.0 74.0 76.0 91.0 98.0 77.0 04:11:55 INFO - PID 27143 | 04:11:55 INFO - PID 27143 | [#4] audio-oscillator Cycles:10 Average:94.20 Median:79.00 stddev:24.67 (31.2%) stddev-sans-first:25.55 04:11:55 INFO - PID 27143 | Values: 79.0 79.0 137.0 79.0 79.0 79.0 128.0 79.0 79.0 124.0 04:11:55 INFO - PID 27143 | 04:11:55 INFO - PID 27143 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 04:11:55 INFO - PID 27143 | Values: 114.0 114.0 114.0 114.0 116.0 114.0 114.0 115.0 114.0 114.0 04:11:55 INFO - PID 27143 | 04:11:55 INFO - PID 27143 | [#6] imaging-darkroom Cycles:10 Average:150.70 Median:151.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 04:11:55 INFO - PID 27143 | Values: 150.0 150.0 151.0 153.0 151.0 150.0 151.0 150.0 151.0 150.0 04:11:55 INFO - PID 27143 | 04:11:55 INFO - PID 27143 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 04:11:55 INFO - PID 27143 | Values: 94.0 95.0 94.0 94.0 94.0 93.0 94.0 94.0 94.0 95.0 04:11:55 INFO - PID 27143 | 04:11:55 INFO - PID 27143 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.00 stddev:0.88 (1.6%) stddev-sans-first:0.93 04:11:55 INFO - PID 27143 | Values: 54.0 54.0 53.0 53.0 56.0 54.0 53.0 54.0 54.0 54.0 04:11:55 INFO - PID 27143 | 04:11:55 INFO - PID 27143 | [#9] json-stringify-tinderbox Cycles:10 Average:55.10 Median:55.00 stddev:0.57 (1.0%) stddev-sans-first:0.44 04:11:55 INFO - PID 27143 | Values: 54.0 55.0 55.0 56.0 55.0 55.0 55.0 56.0 55.0 55.0 04:11:55 INFO - PID 27143 | 04:11:55 INFO - PID 27143 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:79.50 stddev:3.27 (4.1%) stddev-sans-first:3.43 04:11:55 INFO - PID 27143 | Values: 81.0 88.0 81.0 79.0 78.0 77.0 78.0 77.0 80.0 78.0 04:11:55 INFO - PID 27143 | 04:11:55 INFO - PID 27143 | [#11] stanford-crypto-ccm Cycles:10 Average:133.20 Median:130.50 stddev:15.38 (11.8%) stddev-sans-first:16.24 04:11:55 INFO - PID 27143 | Values: 129.0 130.0 127.0 135.0 131.0 135.0 126.0 121.0 123.0 175.0 04:11:55 INFO - PID 27143 | 04:11:55 INFO - PID 27143 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.70 Median:178.00 stddev:5.46 (3.1%) stddev-sans-first:5.62 04:11:55 INFO - PID 27143 | Values: 173.0 178.0 179.0 185.0 178.0 171.0 172.0 173.0 186.0 172.0 04:11:55 INFO - PID 27143 | 04:11:55 INFO - PID 27143 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.00 stddev:2.12 (3.2%) stddev-sans-first:1.00 04:11:55 INFO - PID 27143 | Values: 73.0 69.0 66.0 67.0 68.0 67.0 66.0 66.0 67.0 67.0 04:11:55 INFO - PID 27143 | -------- Summary: end -------- 04:11:55 INFO - PID 27143 | 04:11:55 INFO - PID 27143 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:11:55 INFO - TEST-INFO | 27143: exit 0 04:11:55 INFO - TEST-OK | kraken | took 62003ms 04:11:55 INFO - SUITE-END | took 1174s 04:11:56 INFO - Completed test suite (00:19:34) 04:11:56 INFO - javascript benchmark 04:11:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8511.507967778352, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3148.055583325002, 3173.2066983254185, 3189.282411457422, 3206.5350524173996, 3212.309353489001, 6108.694565271735, 6265.68671566421, 6274.874502509959, 6300.338464461229, 6307.180066591348, 6103.267607887049, 6230.221222347207, 6235.158253635758, 6256.124142620037, 6300.621962682242, 5675.290588676416, 5696.202531645552, 5697.20239166516, 5709.971450142743, 5802.12968054791, 5775.682337471438, 5786.68173250471, 5795.507381872525, 5810.796622118227, 5816.680082595455, 111.5104046248274, 5583.637063590853, 5670.177824215486, 5802.100674395476, 5804.970975145118, 5597.888042239132, 5603.215549823028, 5642.04085305499, 5716.085426331767, 5752.28096487939, 5622.044252477089, 5638.887222255573, 5698.17376480408, 5711.7144142792695, 5721.141828725683, 6137.324894261627, 6166.7224974876235, 6167.105769663419, 6222.315545290015, 6235.314115447297, 6646.93353066468, 6656.101426307483, 6736.191657001143, 6736.797896063126, 6759.391654751096, 6627.900581491282, 6692.59844409337, 6705.295943925915, 6730.663466826688, 6767.492438067165, 6237.812865614039, 6266.216722909637, 6270.3416141305415, 6272.1219029335925, 6272.686365681743, 6820.181578210647, 6948.166220053626, 6968.581885086911, 7004.509684322048, 7014.684339204748, 6567.44176744982, 6581.407673309425, 6598.60408375499, 6672.833179170462, 6678.3989440950545, 6533.314002029813, 6611.63636000015, 6643.701033453506, 6666.799996000128, 6733.0237115617965, 6560.442362399154, 6590.0, 6605.70274337656, 6632.137822083098, 6632.668366581652, 6518.0, 6608.570442921195, 6665.300143484961, 6686.665666716644, 6699.866002679919, 5385.407605163429, 5411.404745477994, 5435.402105768362, 5455.099908515051, 5476.2333273341765, 4578.9542104579195, 4654.790534425892, 4657.69724967876, 4659.906801863944, 4678.95321046792, 5776.826695199151, 5847.532197424196, 5849.473547380756, 5851.063829787298, 5851.736671849691, 6801.625910574966, 6805.761798337134, 6814.216365117975, 6853.040574319599, 6892.965535172292, 5826.096954971986, 5855.502282305966, 5863.120531920246, 5865.442782935615, 5892.94107058924, 5912.46787789101, 5930.584859059911, 5940.762369505258, 6009.579329446897, 6013.579049466583, 6389.105525226472, 6486.4486518646445, 6486.54594178403, 6490.707918143695, 6592.5055620828625, 6650.9667451662435, 6721.563098398588, 6731.259561448334, 6743.52795304324, 6751.122354093936, 6479.125318081999, 6480.805575832733, 6481.675916204265, 6486.837829054311, 6507.674616269073, 6484.0, 6519.8044058678315, 6553.082568440517, 6562.868742625025, 6564.5076619254705, 6727.058211850443, 6764.4588432924265, 6768.661566921733, 6836.453083753188, 6864.4165245954655, 6495.382938620824, 6512.283648798533, 6519.348065193442, 6610.735570577123, 6634.336566343327, 6413.422791948747, 6429.8714025720155, 6492.740290388331, 6495.480361571157, 6539.771108011197, 6399.840003999937, 6419.422251997343, 6449.709763060768, 6452.35476452351, 6456.54804163704, 6565.704543295658, 6596.439302659328, 6614.6361950093205, 6638.867222655616, 6654.4676425884845, 6261.279952805486, 6304.369563043659, 6344.492440604833, 6349.682515874096, 6438.90341644885], "value": 6074.074642814055, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [801.9358451323894, 860.2257967828954, 887.3744010472616, 1167.0721776187925, 1193.7612477504501, 30076.84961575192, 39690.80154599227, 40812.97967550816, 40935.59064409355, 40967.79516102415, 41757.58242417575, 42021.36967945476, 42127.36808947868, 42206.366904496455, 42216.57783422165, 7182.712691492334, 7612.086549614054, 7777.144514103444, 7835.804104897366, 7840.803979900491, 7624.428167887403, 7687.346575541086, 7734.187910269425, 7739.380849532024, 7742.109657389416, 7717.729879454192, 7765.844683106335, 7779.416543759213, 7781.455298129134, 7781.727639532617, 7706.036745406825, 7707.96146019272, 7715.922840771605, 7752.612369381536, 7754.0, 7576.924230757677, 7628.809279767995, 7640.0, 7640.770776876702, 7642.656080476337, 37605.81197093997, 37895.05262368435, 37954.0, 37954.62045379538, 37965.81017094925, 3181.411438883814, 3216.662250463691, 3221.387936292097, 3221.8066915985114, 3223.8871639492504, 30628.387432251453, 30697.386052279053, 30705.692943070506, 30749.846250768827, 30878.07365779008, 4857.149998750205, 4861.392325959255, 4868.075065737498, 4888.437829649564, 4914.238293064581, 190869.0, 193140.0, 193879.0, 194769.0, 194852.0, 46875.29687054697, 46908.76545617318, 46916.2962555562, 46929.765351173024, 47157.05685886332, 49239.0, 49252.75373623109, 49267.26099108516, 49461.75269123631, 49521.75239123782, 16205.351785928666, 16627.750583741254, 16671.33314667424, 16684.082375469465, 16694.58263543397, 11169.162312826571, 11458.140639451907, 12379.62861114168, 12752.171108877894, 12754.68113297175, 13956.2324072177, 14009.71980560383, 14025.158490490603, 14081.85918140826, 14205.147691138565, 5678.4605462480995, 5751.281089863767, 5813.767449302065, 5831.008728516163, 5854.560907931837, 977.9168770654574, 995.124290624246, 1005.9085891807325, 1008.2639673038723, 1021.6526381030337, 22128.33614991553, 22317.330480085624, 22549.887250563643, 22568.435789105075, 22730.20444284475, 1071.908887744535, 1083.8807731149568, 1094.7536804218987, 1099.9880110298545, 1100.4057808783168, 11681.88318116808, 11968.82046769299, 11972.221805582609, 12029.09781766371, 12069.517219311305, 226050.0, 227021.0, 227582.0, 228183.0, 228950.0, 52598.737006314725, 52633.47366526362, 52646.47353526416, 52702.472975270524, 52733.7363313181, 1443.588577255477, 1452.7239824433534, 1468.5227301126963, 1477.6675248069098, 1481.2149560732828, 21130.471738206666, 22012.449688757908, 27986.440271194057, 28264.43471130607, 28710.99511517087, 51393.0, 51643.483565163864, 51741.482585175174, 51792.0, 51937.480625194774, 208904.0, 209841.0, 210013.0, 210311.0, 210425.0, 34442.82778586191, 34602.307953841286, 36442.63557364392, 36787.0, 36858.0, 44517.55482445134, 45389.773051134536, 46802.82992925204, 46868.765656172865, 47116.528834711215, 34034.0, 34128.48807267943, 34243.0, 34381.48427773635, 34621.826890865384, 33823.83088084544, 33974.830125849214, 33998.0, 34058.489122663676, 34419.311613768084, 36256.63743362533, 36535.08662283464, 36706.26587468289, 36741.63258367382, 36842.63157368392, 32556.0, 32783.180420489676, 32807.0, 33052.0, 33193.502097468074, 24232.636510452005, 24426.389340265923, 25182.0, 25249.368765781004, 25582.1832494647], "value": 17419.789312632827, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.792506772494, 567.2002476508125, 573.5526289494196, 578.2656026845905, 580.2717589425273, 22088.668669969964, 22764.54470910581, 22772.31683049507, 22774.65838012431, 22808.31575052747, 24365.512689746196, 26654.33364165897, 26767.86616066922, 26816.195514134557, 26898.327541811464, 6459.031145328203, 6565.671716414184, 6585.769498067569, 6593.044008618747, 6607.174103237096, 6145.108959200936, 6477.481801455896, 6512.772052978146, 6524.184476940382, 6588.308227636101, 6452.032195170738, 6471.870562588769, 6481.0, 6489.5781774184525, 6496.447801936841, 6451.58064725796, 6457.612543247396, 6462.32145624712, 6465.062565927961, 6467.74129034838, 6012.368701286389, 6026.9095963560585, 6027.60820546663, 6036.124761909542, 6036.96981515094, 29167.124986250234, 30122.493875306365, 30354.392912141855, 30498.170109793482, 30742.077737667907, 1927.6241132979076, 1965.4202010406964, 1996.331229038274, 1999.8800071995727, 2001.3295545991964, 18882.244710211577, 19580.118894649633, 19618.70571941422, 19624.215031398726, 19663.60672786536, 2269.296518079401, 2309.226409152936, 2354.5761762882676, 2360.7167139943317, 2449.7182823975295, 138541.0, 140824.0, 141717.29141354226, 142000.28999854936, 142423.0, 14287.357068931922, 14691.85308146905, 14920.70158596822, 15239.542813715607, 15242.314095865713, 23392.298231053097, 23482.178123765585, 23494.0, 23520.529589408117, 23553.528929421314, 9830.459324737065, 9947.751306217402, 10058.446785426871, 10211.897881021094, 10213.131883789962, 7559.886601700869, 9241.58412871409, 9327.673531426368, 9352.298577606707, 9361.953190234006, 7926.643301051467, 9092.227160691284, 9107.81784364309, 9171.63313467454, 9257.259419246444, 2650.430157516105, 2654.9601755973677, 2771.473420050184, 2773.6671599407796, 2872.7558157556423, 944.3153713557616, 967.9758006049764, 976.32633482898, 982.8673129127476, 984.0, 19779.10994005273, 20224.0, 20237.392878213675, 20302.18791248363, 20711.275105371238, 1028.8199565076231, 1035.0839507036176, 1036.3367444835312, 1037.2894567221326, 1049.1030169205371, 11090.5563777448, 13385.73228535424, 14320.928395358165, 14352.784708229385, 14621.707565848836, 475030.0, 477052.0, 477594.0, 486279.0, 499361.0, 118707.0, 119547.0, 120322.0, 121989.0, 122371.38814305872, 1260.0612543655036, 1261.3377976562379, 1289.8258735070644, 1295.6784080238103, 1303.9217646941213, 21348.35954921355, 21503.892480537495, 21575.784242157377, 21650.8917455418, 21809.01859416362, 56049.15926261028, 56442.435575643714, 56983.71508142599, 57715.711421444306, 58401.415985839594, 72344.63827680828, 73286.26713732794, 73613.0, 73619.63190184014, 74350.62824685842, 12215.938920305342, 12852.421641025989, 14263.286835658384, 14312.427502899767, 14900.478483253035, 23522.29433117009, 23559.293221203392, 23615.763842361357, 25052.874735626207, 25247.87376063108, 18594.721079183553, 19112.713309300092, 19417.12622931943, 19429.61140777148, 19544.804551954297, 17989.190486428404, 17998.190081446628, 18080.276788928822, 18107.637847242717, 18234.908825455786, 19794.505137371103, 19856.50358741043, 19933.302334418226, 20067.69898451495, 20302.187912483925, 14793.778093328394, 14908.85091149118, 14922.701545969237, 15017.924910375816, 15133.243337833284, 18704.719429208846, 18887.90556047211, 18939.242430302635, 19047.619047619246, 19201.807981920003], "value": 12210.379732167847, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1327.1373607155347, 1368.4799776085085, 1372.5607805502236, 1384.1072508232185, 1384.8753612174908, 11679.065674746022, 12324.938375308133, 12340.25958442494, 14541.272936353167, 15075.396984120622, 14430.20633865137, 14715.632109197275, 14722.63193420165, 14731.926340368283, 14747.0, 2486.825922185448, 2570.858602776851, 2599.3241757143182, 2606.205107442239, 2638.023931145479, 2707.6615423072117, 2767.529519981608, 2771.1547977866744, 2773.5978283149034, 2774.9306267343377, 2697.757201851833, 2733.289344770354, 2761.2130542795308, 2763.6821765496925, 2776.444711057786, 2596.143272719998, 2600.0249906285144, 2614.49017441598, 2640.973590264092, 2687.932801679954, 2603.6615240018677, 2611.856347900865, 2629.855357955312, 2630.18464276075, 2635.143578337048, 13920.791188132187, 14266.572002839932, 14501.564953051426, 14510.854891451056, 14520.491782787658, 7702.268284512962, 8027.558484283362, 8048.476849004796, 8054.476459030145, 8057.194280571955, 4930.975345123287, 4940.3330550375595, 5024.748762561857, 5102.974485127587, 5117.667351622133, 1855.1188185611861, 1876.6340563590106, 1890.2911408221917, 1917.8849269043762, 1941.6990366493217, 23963.041478340845, 23965.880170599034, 24095.87952060246, 24119.87940060306, 24194.15320463793, 6337.841553961188, 6601.768938087144, 6767.052612634235, 6773.729050837911, 6852.554583952027, 16367.345306187857, 16413.097279649734, 16431.753523697153, 16450.75323870143, 16469.094199819127, 7648.579328137006, 7784.41616878725, 7792.493487923267, 7794.10367807698, 7797.844043119106, 5811.912821307684, 5988.490978266809, 6866.34769696878, 6918.654067296615, 7174.354308112295, 5224.791008359699, 5274.077036518594, 5340.946590534123, 5394.190871369247, 5406.351237851483, 1485.7474229381032, 1519.8176218853587, 1552.7748476471074, 1553.9300731466885, 1566.6788308396751, 910.39003867409, 925.1165137293868, 926.416357694648, 929.7350255177242, 931.9934470771686, 7357.705691772377, 7372.115346158495, 7386.741464048732, 7427.071616047994, 7440.516366436273, 718.4647437658873, 741.1809950005166, 985.9408435493893, 1005.7837564923576, 1014.6043043213152, 4946.332245146859, 4973.676711013773, 5164.870878227999, 5241.554467870197, 5344.8663783404945, 19376.903115484332, 19516.414507564798, 19810.0, 20082.497937551678, 20781.792182078287, 19923.302684405975, 20134.597308053755, 20271.391858244275, 20289.898550507154, 20308.0, 11168.888311116947, 11189.944050279697, 11317.71705707364, 11329.773404532029, 11379.317240965569, 8082.191780822106, 8358.540280284642, 8597.957010214908, 8749.781255468664, 8778.91221087781, 17179.742303865703, 17705.64588708193, 17753.0, 18057.458276251735, 18058.819411805714, 17641.735373969143, 18042.72935905936, 18240.17919193666, 18298.817011829713, 18302.26790928401, 9812.264080194156, 11603.709907252387, 11766.411679416165, 11875.940620296844, 11934.701632458911, 11492.253003554742, 13165.407556659782, 13552.525661601796, 13555.457781689016, 13576.524821631196, 10809.297395669257, 10838.566457341618, 10980.286281391684, 11056.0, 11254.94372528132, 10559.891211422997, 10689.09142722846, 10795.676129716121, 10894.67315980522, 11078.169137314895, 9189.448633081769, 9362.391444556082, 9548.236141108555, 9571.808563828545, 9577.473238971645, 6689.331066893272, 7125.0, 7177.964110179416, 7210.603416812126, 7220.133583969957, 6923.099997000358, 7101.467389945671, 7133.928660713326, 7162.964185179041, 7231.2768723127265], "value": 6450.901264404494, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [504.4287045852167, 516.7209706758351, 517.3119750731528, 521.0724909660803, 536.4474591171092, 6084.756609735606, 6085.421884920926, 6103.938960610403, 6176.0, 6183.134361189437, 5974.372690867462, 6023.939760602393, 6047.727852246649, 6087.3303936566945, 6091.9287442269615, 5021.5688528769215, 5051.494850514938, 5075.111855425304, 5085.491450854922, 5085.847424577269, 4690.530946905316, 4890.535399137094, 4987.451380348159, 4996.825111121111, 5018.84943451697, 4795.0, 4844.491328410519, 4850.102730994778, 4870.050340183666, 4875.488073752258, 4722.645801564862, 4827.117424204563, 4838.588719958808, 4895.437024742147, 4898.706077635354, 4343.261645520269, 4344.304911214223, 4382.189294980439, 4383.320585309282, 4388.890277743082, 5870.178175055496, 5969.611975221596, 5972.581919265654, 5987.036416973626, 6005.399460054004, 5573.442655734394, 5580.274564306655, 5586.441355864422, 5644.322681278232, 5656.0101982152955, 6378.298387177407, 6421.871562568723, 6450.903236451457, 6482.573833756566, 6502.707378167994, 4729.810807567693, 4784.473707892129, 4788.0, 4799.208130658437, 4842.370491836074, 6449.774257900951, 6596.901046484307, 6598.967005164944, 6715.496337774637, 6789.321067893171, 4870.09903167915, 4881.707097574157, 4899.436564795023, 4913.729744863996, 4922.827701030446, 4865.829695960624, 4914.606831453547, 4951.331570238044, 4980.377452818398, 5028.974855125774, 5563.693996830132, 5603.887922241533, 5613.578981576398, 5637.436256374412, 5645.435456454322, 6471.838204044842, 6477.77327793525, 6496.577722448026, 6505.251896032017, 6508.60948343101, 1716.5794380376888, 1717.0511469481978, 1744.97382539262, 1761.9207135678926, 1765.6203916158088, 1159.588346137126, 1197.4491733802374, 1210.933398663082, 1217.817327400897, 1225.8161275808523, 5579.38626751057, 5592.161175823578, 5669.716514174274, 5675.858103547362, 5709.9714501427225, 6469.159009328757, 6525.249596296487, 6548.312427195171, 6574.408303252731, 6591.802245932629, 5567.582431317667, 5587.720613969285, 5605.523530499871, 5664.20701101846, 5703.116017017369, 3427.485877118452, 3470.913227169341, 3485.0, 3490.616032236452, 3524.1189702574356, 6287.245530536274, 6346.174997250328, 6375.808725738235, 6408.1349017881985, 6441.58129721576, 6681.164854393201, 6739.932600674028, 6754.45964322853, 6768.544762875907, 6791.185057792997, 6274.686265686789, 6282.403171698681, 6332.208473940757, 6422.74309027643, 6450.0647406125845, 6464.515161362822, 6470.288268290578, 6472.514561407819, 6582.934170658232, 6643.800685979429, 6438.517111216771, 6444.355564443518, 6452.387023232785, 6575.027491752359, 6611.30581288977, 5800.637443283531, 6344.651044192614, 6376.776812811529, 6406.935930640634, 6424.453921416732, 4946.961138161027, 4955.975220123876, 4956.132676781621, 5292.867678307919, 5443.428440013741, 6387.137736405712, 6545.5090868184125, 6615.702293396713, 6671.664917278914, 6699.598024118373, 6415.486761059011, 6456.386643268882, 6467.320931302145, 6515.218173819172, 6526.379993900572, 6475.708593113415, 6488.708008139551, 6493.8701225976165, 6510.414062734377, 6542.5420220586, 6422.233885681475, 6424.839379015562, 6440.903386449113, 6452.741890324334, 6468.514861385321, 6403.167588213502, 6414.903776443451, 6500.122483464672, 6504.902426463702, 6547.901781473377, 6258.561900666909, 6260.40526150015, 6293.779717710041, 6314.526410519321, 6365.936340636719], "value": 4975.312174042931, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [913.7167478081795, 914.8993610702821, 934.878465799446, 937.2174234514181, 947.5451783144093, 17117.48647540574, 17751.733723994133, 17759.0, 17795.0, 19737.506562335948, 21391.465213369673, 21730.0, 21923.0, 21948.0, 21951.231706890263, 1014.2849291249652, 1033.9172866170725, 1035.5340096956363, 1039.0, 1040.921930855189, 1010.0555980158575, 1039.4958445154093, 1044.310754901765, 1048.051513380392, 1054.7679510507676, 1079.5897558927597, 1081.1891081688734, 1081.621432498627, 1081.983770243447, 1082.5453309609982, 1077.3966578715945, 1079.2283517285139, 1079.740862193072, 1080.2384319055047, 1080.254624309224, 791.8218400859818, 792.8652129138061, 792.8771040488676, 792.8929594504725, 792.9643166057541, 17645.7353139703, 18114.094295285184, 18250.269989200417, 18277.54306142344, 18347.16528347168, 20976.790232097635, 21444.463888402915, 21895.67156492654, 21937.890310548344, 22152.0, 15989.0, 16974.066426346548, 17144.485665430057, 17148.571285717833, 17159.142042897805, 3567.161716996504, 3586.7309951753464, 3601.2797440512004, 3611.368010598135, 3617.4031284838234, 124950.33236238758, 124957.0, 126878.99999999908, 129139.0, 129391.0, 16670.249838757285, 16841.831581684026, 17211.225494852762, 17286.22212000463, 17337.65324693499, 30784.53823192609, 30928.0, 31610.525842112387, 31689.366212675617, 31746.523802142987, 7286.089238845145, 7750.3024727773645, 7816.140224575292, 7905.604719763989, 8374.0, 4161.542230354658, 4285.100128972888, 4290.699651024461, 4315.870523884289, 4331.7834108294455, 5339.626226164131, 5391.7304134793885, 5438.374586922476, 5511.118221084607, 5511.944880551223, 1050.3540322701483, 1070.1813112968584, 1074.0762943868267, 1084.9132069434427, 1091.1816137896578, 681.2540268406087, 703.0368395298372, 705.9576425414389, 707.8938159276047, 712.0920825946855, 11935.880641193651, 12065.517379304905, 12344.876551234373, 12562.81155782664, 13637.454501819817, 698.0645934447864, 700.961447120403, 701.5089437393844, 708.450950513346, 716.7563028570311, 5310.575153987672, 5314.096603577401, 5343.0, 5345.625806193607, 5452.836414907559, 108216.0, 111145.0, 113589.0, 115020.0, 115964.0, 99535.0, 99721.50139249257, 101177.98822011685, 102974.0, 107206.46396767967, 87715.56142219248, 87918.56040719755, 88642.0, 90426.0, 92679.53660231656, 10198.745031374276, 10311.22665800083, 10354.275200735876, 10517.263791534519, 12463.688407789878, 39029.41455878107, 40121.39817902676, 40152.0, 41091.794541027106, 41413.792931035154, 70857.29142708507, 72380.27619723736, 73693.26306736864, 74220.62889685517, 75457.0, 17676.91161544184, 18648.16083276283, 19444.0, 19797.0, 19811.504712382306, 16968.321267149175, 17457.56356091108, 17597.12014399249, 17735.733963990293, 20950.47623809417, 17329.220185091952, 18771.061446927324, 19797.30709425163, 19804.60390792147, 19989.60020799605, 16623.418180363627, 16659.167041647626, 16866.831331686528, 16921.323147073977, 17006.914965425094, 16801.0, 17233.655326893644, 17338.959662420297, 17367.218475168902, 17417.912910435367, 13747.656308592364, 13808.792868107188, 14149.575512734635, 14193.503227386991, 14358.784618230526, 9081.228095611947, 10765.138788897026, 14786.482473113389, 14939.0, 14999.400023998918], "value": 9168.922725829638, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1519.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 107.0, 100.0, 107.0, 108.0, 109.0, 109.0, 98.0, 108.0, 108.0], "value": 105.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 116.0, 151.0, 184.0, 119.0, 144.0, 150.0, 120.0, 168.0, 117.0], "value": 140.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 164.0, 163.0, 164.0, 162.0, 164.0, 168.0, 167.0, 163.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 181.0, 76.0, 74.0, 76.0, 91.0, 98.0, 77.0], "value": 89.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 137.0, 79.0, 79.0, 79.0, 128.0, 79.0, 79.0, 124.0], "value": 94.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 116.0, 114.0, 114.0, 115.0, 114.0, 114.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 151.0, 153.0, 151.0, 150.0, 151.0, 150.0, 151.0, 150.0], "value": 150.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 95.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 53.0, 56.0, 54.0, 53.0, 54.0, 54.0, 54.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 55.0, 56.0, 55.0, 55.0, 55.0, 56.0, 55.0, 55.0], "value": 55.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 88.0, 81.0, 79.0, 78.0, 77.0, 78.0, 77.0, 80.0, 78.0], "value": 79.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 130.0, 127.0, 135.0, 131.0, 135.0, 126.0, 121.0, 123.0, 175.0], "value": 133.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 178.0, 179.0, 185.0, 178.0, 171.0, 172.0, 173.0, 186.0, 172.0], "value": 176.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 69.0, 66.0, 67.0, 68.0, 67.0, 66.0, 66.0, 67.0, 67.0], "value": 67.6, "unit": "score"}]}]} 04:11:56 INFO - Return code: 0 04:11:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:11:56 INFO - # TBPL SUCCESS # 04:11:56 INFO - Running post-action listener: _package_coverage_data 04:11:56 INFO - Running post-action listener: _resource_record_post_action 04:11:56 INFO - [mozharness: 2017-08-11 11:11:56.291789Z] Finished run-tests step (success) 04:11:56 INFO - Running post-run listener: _resource_record_post_run 04:11:56 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 432271360; Read time: 20; Write time: 245856 04:11:56 INFO - TinderboxPrint: CPU usage
13.1% 04:11:56 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 04:11:56 INFO - TinderboxPrint: I/O write bytes / time
432,271,360 / 245,856 04:11:56 INFO - TinderboxPrint: CPU idle
8,263.6 (86.9%) 04:11:56 INFO - TinderboxPrint: CPU user
1,199.4 (12.6%) 04:11:56 INFO - TinderboxPrint: Swap in / out
0 / 0 04:11:56 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106192896; Read time: 0; Write time: 58376 04:11:56 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:11:56 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 326078464; Read time: 0; Write time: 187480 04:11:56 INFO - Running post-run listener: _upload_blobber_files 04:11:56 INFO - Blob upload gear active. 04:11:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:11:56 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:11:56 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:11:56 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:11:57 INFO - (blobuploader) - INFO - Open directory for files ... 04:11:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:11:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:11:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:11:58 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:11:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:11:58 INFO - (blobuploader) - INFO - Done attempting. 04:11:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:11:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:11:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:11:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:11:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:11:58 INFO - (blobuploader) - INFO - Done attempting. 04:11:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:11:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:11:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:12:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:12:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:12:05 INFO - (blobuploader) - INFO - Done attempting. 04:12:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:12:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:12:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:12:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:12:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:12:06 INFO - (blobuploader) - INFO - Done attempting. 04:12:06 INFO - (blobuploader) - INFO - Iteration through files over. 04:12:06 INFO - Return code: 0 04:12:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:12:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:12:06 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4d33e65fedfe3d28ee429da018853e8f28608c53c59a969b9080db6e2bcf4a8988ff4eab3dea2793f164b5d33419a9d8bdba4674c732394b3716e399a41b996c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/57fa6b5e19d5c814acf942686885f1f5b2474efee7c816677e8df375845553811e796f58b10bf5628d28657e55e4c297597d6d859336e76c32e93c0ec30aded5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a32fdd8a5cf7270aa0c5df43582023c6d77e0681ba76e9cb9bc0545e6e3af6e57984e2b5917390020503fdde718b32ff4c103b9e49039e7aa72755351d6d2fca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d6afaa00a8240eb17f1b751aadb59ec9e863d1bf229337968226823e62d628f3995234bc89621a3c35e2230df3dfa1de755f676ea1707479a0fff3012f1c9d47"} 04:12:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:12:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:12:06 INFO - Contents: 04:12:06 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4d33e65fedfe3d28ee429da018853e8f28608c53c59a969b9080db6e2bcf4a8988ff4eab3dea2793f164b5d33419a9d8bdba4674c732394b3716e399a41b996c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/57fa6b5e19d5c814acf942686885f1f5b2474efee7c816677e8df375845553811e796f58b10bf5628d28657e55e4c297597d6d859336e76c32e93c0ec30aded5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a32fdd8a5cf7270aa0c5df43582023c6d77e0681ba76e9cb9bc0545e6e3af6e57984e2b5917390020503fdde718b32ff4c103b9e49039e7aa72755351d6d2fca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d6afaa00a8240eb17f1b751aadb59ec9e863d1bf229337968226823e62d628f3995234bc89621a3c35e2230df3dfa1de755f676ea1707479a0fff3012f1c9d47"} 04:12:06 INFO - Running post-run listener: copy_logs_to_upload_dir 04:12:06 INFO - Copying logs to upload dir... 04:12:06 INFO - mkdir: /builds/slave/test/build/upload/logs 04:12:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.676075 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-08-11 04:12:06.179069) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-11 04:12:06.182857) ========= 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=d2a8c569965ab8367867b893000001a1-1502448671.107665-135259192 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4d33e65fedfe3d28ee429da018853e8f28608c53c59a969b9080db6e2bcf4a8988ff4eab3dea2793f164b5d33419a9d8bdba4674c732394b3716e399a41b996c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/57fa6b5e19d5c814acf942686885f1f5b2474efee7c816677e8df375845553811e796f58b10bf5628d28657e55e4c297597d6d859336e76c32e93c0ec30aded5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a32fdd8a5cf7270aa0c5df43582023c6d77e0681ba76e9cb9bc0545e6e3af6e57984e2b5917390020503fdde718b32ff4c103b9e49039e7aa72755351d6d2fca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d6afaa00a8240eb17f1b751aadb59ec9e863d1bf229337968226823e62d628f3995234bc89621a3c35e2230df3dfa1de755f676ea1707479a0fff3012f1c9d47"} build_url:https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011251 build_url: 'https://queue.taskcluster.net/v1/task/DccvNO8hRT2EKCynlXqtsg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4d33e65fedfe3d28ee429da018853e8f28608c53c59a969b9080db6e2bcf4a8988ff4eab3dea2793f164b5d33419a9d8bdba4674c732394b3716e399a41b996c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/57fa6b5e19d5c814acf942686885f1f5b2474efee7c816677e8df375845553811e796f58b10bf5628d28657e55e4c297597d6d859336e76c32e93c0ec30aded5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a32fdd8a5cf7270aa0c5df43582023c6d77e0681ba76e9cb9bc0545e6e3af6e57984e2b5917390020503fdde718b32ff4c103b9e49039e7aa72755351d6d2fca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d6afaa00a8240eb17f1b751aadb59ec9e863d1bf229337968226823e62d628f3995234bc89621a3c35e2230df3dfa1de755f676ea1707479a0fff3012f1c9d47"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-11 04:12:06.207802) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 04:12:06.208146) ========= 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=d2a8c569965ab8367867b893000001a1-1502448671.107665-135259192 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004484 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 04:12:06.293447) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-11 04:12:06.293762) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-11 04:12:06.294086) ========= ========= Total master_lag: 0.18 =========