builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-052 starttime: 1500804336.29 results: success (0) revision: c023ce417c98641c0dfacaaf236dcfdcb7794f88 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-23 03:05:36.295004) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-23 03:05:36.295673) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-23 03:05:36.296006) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-23 03:05:36.366619) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-23 03:05:36.366991) ========= 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=826874ccc97bd7bf541b4875000001d5-1500800524.142068-1259549072 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-23 03:05:37-- 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.0M=0s 2017-07-23 03:05:37 (69.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.100189 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-23 03:05:36.509445) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-23 03:05:36.513798) ========= 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=826874ccc97bd7bf541b4875000001d5-1500800524.142068-1259549072 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019962 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-23 03:05:36.567609) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-07-23 03:05:36.572179) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c023ce417c98641c0dfacaaf236dcfdcb7794f88 --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 c023ce417c98641c0dfacaaf236dcfdcb7794f88 --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=826874ccc97bd7bf541b4875000001d5-1500800524.142068-1259549072 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-23 03:05:37,524 truncating revision to first 12 chars 2017-07-23 03:05:37,524 Setting DEBUG logging. 2017-07-23 03:05:37,524 attempt 1/10 2017-07-23 03:05:37,524 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c023ce417c98?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-23 03:05:40,259 unpacking tar archive at: mozilla-central-c023ce417c98/testing/mozharness/ program finished with exit code 0 elapsedTime=3.157325 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-07-23 03:05:39.753626) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-23 03:05:39.757134) ========= script_repo_revision: c023ce417c98641c0dfacaaf236dcfdcb7794f88 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-23 03:05:39.757587) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-23 03:05:39.757885) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-23 03:05:39.771283) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-07-23 03:05:39.771575) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1500800524.142068-1259549072 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:05:40 INFO - MultiFileLogger online at 20170723 03:05:40 in /builds/slave/test 03:05:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:05:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:05:40 INFO - {'append_to_log': False, 03:05:40 INFO - 'base_work_dir': '/builds/slave/test', 03:05:40 INFO - 'blob_upload_branch': 'Firefox', 03:05:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:05:40 INFO - 'branch': 'Firefox', 03:05:40 INFO - 'buildbot_json_path': 'buildprops.json', 03:05:40 INFO - 'code_coverage': False, 03:05:40 INFO - 'config_files': ('talos/linux_config.py',), 03:05:40 INFO - 'default_actions': ('clobber', 03:05:40 INFO - 'read-buildbot-config', 03:05:40 INFO - 'download-and-extract', 03:05:40 INFO - 'populate-webroot', 03:05:40 INFO - 'create-virtualenv', 03:05:40 INFO - 'install', 03:05:40 INFO - 'setup-mitmproxy', 03:05:40 INFO - 'run-tests'), 03:05:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:05:40 INFO - 'disable_ccov_upload': False, 03:05:40 INFO - 'download_minidump_stackwalk': True, 03:05:40 INFO - 'download_symbols': 'ondemand', 03:05:40 INFO - 'enable_stylo': False, 03:05:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:05:40 INFO - 'tooltool.py': '/tools/tooltool.py', 03:05:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:05:40 INFO - '/tools/misc-python/virtualenv.py')}, 03:05:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:05:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:05:40 INFO - 'gecko_profile': False, 03:05:40 INFO - 'gecko_profile_interval': 0, 03:05:40 INFO - 'installer_path': 'installer.exe', 03:05:40 INFO - 'log_level': 'info', 03:05:40 INFO - 'log_name': 'talos', 03:05:40 INFO - 'log_to_console': True, 03:05:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:05:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:05:40 INFO - 'opt_config_files': (), 03:05:40 INFO - 'pip_index': False, 03:05:40 INFO - 'suite': 'dromaeojs-e10s', 03:05:40 INFO - 'system_bits': '32', 03:05:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:05:40 INFO - 'title': 'talos-linux64-ix-052', 03:05:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:05:40 INFO - 'use_talos_json': True, 03:05:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:05:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:05:40 INFO - 'work_dir': 'build'} 03:05:40 INFO - [mozharness: 2017-07-23 10:05:40.830435Z] Running clobber step. 03:05:40 INFO - Running pre-action listener: _resource_record_pre_action 03:05:40 INFO - Running main action method: clobber 03:05:40 INFO - rmtree: /builds/slave/test/build 03:05:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:05:42 INFO - Running post-action listener: _resource_record_post_action 03:05:42 INFO - [mozharness: 2017-07-23 10:05:42.538132Z] Finished clobber step (success) 03:05:42 INFO - [mozharness: 2017-07-23 10:05:42.538235Z] Running read-buildbot-config step. 03:05:42 INFO - Running pre-action listener: _resource_record_pre_action 03:05:42 INFO - Running main action method: read_buildbot_config 03:05:42 INFO - Using buildbot properties: 03:05:42 INFO - { 03:05:42 INFO - "project": "", 03:05:42 INFO - "product": "firefox", 03:05:42 INFO - "who": "archaeopteryx@coole-files.de", 03:05:42 INFO - "installer_path": "public/build/target.tar.bz2", 03:05:42 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 03:05:42 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 03:05:42 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 03:05:42 INFO - "stage_platform": "linux64-stylosequential", 03:05:42 INFO - "basedir": "/builds/slave/test", 03:05:42 INFO - "buildnumber": 118, 03:05:42 INFO - "platform": "ubuntu64_hw_styloseq", 03:05:42 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:05:42 INFO - "slavebuilddir": "test", 03:05:42 INFO - "taskId": "F7PjTP9SR46l6RfW_2FZng", 03:05:42 INFO - "branch": "mozilla-central", 03:05:42 INFO - "script_repo_revision": "production", 03:05:42 INFO - "revision": "c023ce417c98641c0dfacaaf236dcfdcb7794f88", 03:05:42 INFO - "slavename": "talos-linux64-ix-052", 03:05:42 INFO - "repo_path": "mozilla-central" 03:05:42 INFO - } 03:05:42 INFO - Finding installer, test and symbols from parent task. 03:05:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F7PjTP9SR46l6RfW_2FZng'}, attempt #1 03:05:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F7PjTP9SR46l6RfW_2FZng'}, attempt #1 03:05:43 INFO - Task dependencies: ZesVv5jtR_WeV4mZcPNddA 03:05:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA'}, attempt #1 03:05:44 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/target.tar.bz2 03:05:44 INFO - Set test_url: https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/test_packages.json 03:05:44 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/target.crashreporter-symbols.zip 03:05:44 INFO - Running post-action listener: _resource_record_post_action 03:05:44 INFO - [mozharness: 2017-07-23 10:05:44.075205Z] Finished read-buildbot-config step (success) 03:05:44 INFO - [mozharness: 2017-07-23 10:05:44.075428Z] Running download-and-extract step. 03:05:44 INFO - Running pre-action listener: _resource_record_pre_action 03:05:44 INFO - Running main action method: download_and_extract 03:05:44 INFO - mkdir: /builds/slave/test/build/tests 03:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:05:44 INFO - trying https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/target.test_packages.json 03:05:44 INFO - Downloading https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:05:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:05:44 INFO - Downloaded 989 bytes. 03:05:44 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:05:44 INFO - Using the following test package requirements: 03:05:44 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:05:44 INFO - u'common': [u'target.common.tests.zip'], 03:05:44 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:05:44 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:05:44 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:05:44 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:05:44 INFO - u'mozbase': [u'target.common.tests.zip'], 03:05:44 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:05:44 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:05:44 INFO - u'web-platform': [u'target.common.tests.zip', 03:05:44 INFO - u'target.web-platform.tests.tar.gz'], 03:05:44 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:05:44 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:05:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/target.common.tests.zip 03:05:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:05:44 INFO - Fetch https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/target.common.tests.zip into memory 03:05:46 INFO - Content-Length response header: 72766777 03:05:46 INFO - Bytes received: 72766777 03:05:57 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:05:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/target.common.tests.zip 03:05:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:05:57 INFO - Fetch https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/target.common.tests.zip into memory 03:05:58 INFO - Content-Length response header: 72766777 03:05:58 INFO - Bytes received: 72766777 03:06:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/target.talos.tests.zip 03:06:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:06:10 INFO - Fetch https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/target.talos.tests.zip into memory 03:06:11 INFO - Content-Length response header: 14498826 03:06:11 INFO - Bytes received: 14498826 03:06:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:11 INFO - trying https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/target.tar.bz2 03:06:11 INFO - Downloading https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:06:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:06:13 INFO - Downloaded 62011074 bytes. 03:06:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/target.tar.bz2 03:06:13 INFO - mkdir: /builds/slave/test/properties 03:06:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:06:13 INFO - Writing to file /builds/slave/test/properties/build_url 03:06:13 INFO - Contents: 03:06:13 INFO - build_url:https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/target.tar.bz2 03:06:13 INFO - Running post-action listener: _resource_record_post_action 03:06:13 INFO - Running post-action listener: set_extra_try_arguments 03:06:13 INFO - [mozharness: 2017-07-23 10:06:13.191056Z] Finished download-and-extract step (success) 03:06:13 INFO - [mozharness: 2017-07-23 10:06:13.191171Z] Running populate-webroot step. 03:06:13 INFO - Running pre-action listener: _resource_record_pre_action 03:06:13 INFO - Running main action method: populate_webroot 03:06:13 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:06:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:06:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:06:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:06:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:06:13 INFO - 'tests': ['damp', 'tps']}, 03:06:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:06:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:06:13 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:06:13 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:06:13 INFO - 'other-e10s': {'tests': ['a11yr', 03:06:13 INFO - 'ts_paint', 03:06:13 INFO - 'tpaint', 03:06:13 INFO - 'sessionrestore', 03:06:13 INFO - 'sessionrestore_many_windows', 03:06:13 INFO - 'sessionrestore_no_auto_restore', 03:06:13 INFO - 'tabpaint']}, 03:06:13 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:06:13 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:06:13 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:06:13 INFO - 'talos_options': ['--mitmproxy', 03:06:13 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:06:13 INFO - '--firstNonBlankPaint'], 03:06:13 INFO - 'tests': ['quantum_pageload_google', 03:06:13 INFO - 'quantum_pageload_youtube', 03:06:13 INFO - 'quantum_pageload_amazon', 03:06:13 INFO - 'quantum_pageload_facebook']}, 03:06:13 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:06:13 INFO - 'talos_options': ['--stylo', 03:06:13 INFO - '--mitmproxy', 03:06:13 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:06:13 INFO - '--firstNonBlankPaint'], 03:06:13 INFO - 'tests': ['quantum_pageload_google', 03:06:13 INFO - 'quantum_pageload_youtube', 03:06:13 INFO - 'quantum_pageload_amazon', 03:06:13 INFO - 'quantum_pageload_facebook']}, 03:06:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:06:13 INFO - 'tsvgr_opacity', 03:06:13 INFO - 'tart', 03:06:13 INFO - 'tscrollx', 03:06:13 INFO - 'cart', 03:06:13 INFO - 'tsvg_static']}, 03:06:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:06:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:06:13 INFO - 'talos_options': ['--xperf_path', 03:06:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:06:13 INFO - 'tests': ['tp5n']}}} 03:06:13 INFO - Running post-action listener: _resource_record_post_action 03:06:13 INFO - [mozharness: 2017-07-23 10:06:13.199869Z] Finished populate-webroot step (success) 03:06:13 INFO - [mozharness: 2017-07-23 10:06:13.199975Z] Running create-virtualenv step. 03:06:13 INFO - Running pre-action listener: _resource_record_pre_action 03:06:13 INFO - Running main action method: create_virtualenv 03:06:13 INFO - Creating virtualenv /builds/slave/test/build/venv 03:06:13 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:06:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:06:13 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:06:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:06:13 INFO - Using real prefix '/usr' 03:06:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:06:13 INFO - Installing distribute.............................................................................................................................................................................................done. 03:06:15 INFO - Installing pip.................done. 03:06:15 INFO - Return code: 0 03:06:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:06:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:06:15 INFO - Reading from file tmpfile_stdout 03:06:15 INFO - Output received: 03:06:15 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:06:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:06: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:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06: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:06:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:15 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 0xc2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf99eb0>, '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 0xf9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9b240>, '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': '826874ccc97bd7bf541b4875000001d5-1500800524.142068-1259549072', '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:06:15 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:06:15 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:06:15 INFO - Using env: {'DISPLAY': ':0', 03:06:15 INFO - 'HOME': '/home/cltbld', 03:06:15 INFO - 'LANG': 'en_US.UTF-8', 03:06:15 INFO - 'LANGUAGE': 'en_US:en', 03:06:15 INFO - 'LOGNAME': 'cltbld', 03:06:15 INFO - 'MAIL': '/var/mail/cltbld', 03:06:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:15 INFO - 'MOZ_NO_REMOTE': '1', 03:06:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:15 INFO - 'NO_EM_RESTART': '1', 03:06:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:15 INFO - 'PWD': '/builds/slave/test', 03:06:15 INFO - 'SHELL': '/bin/bash', 03:06:15 INFO - 'SHLVL': '1', 03:06:15 INFO - 'TERM': 'linux', 03:06:15 INFO - 'TMOUT': '86400', 03:06:15 INFO - 'USER': 'cltbld', 03:06:15 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1500800524.142068-1259549072', 03:06:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:15 INFO - '_': '/tools/buildbot/bin/python'} 03:06:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:16 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:06:16 INFO - Cleaning up... 03:06:16 INFO - Return code: 0 03:06:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:06:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:16 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 0xc2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf99eb0>, '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 0xf9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9b240>, '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': '826874ccc97bd7bf541b4875000001d5-1500800524.142068-1259549072', '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:06:16 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:06:16 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:06:16 INFO - Using env: {'DISPLAY': ':0', 03:06:16 INFO - 'HOME': '/home/cltbld', 03:06:16 INFO - 'LANG': 'en_US.UTF-8', 03:06:16 INFO - 'LANGUAGE': 'en_US:en', 03:06:16 INFO - 'LOGNAME': 'cltbld', 03:06:16 INFO - 'MAIL': '/var/mail/cltbld', 03:06:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:16 INFO - 'MOZ_NO_REMOTE': '1', 03:06:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:16 INFO - 'NO_EM_RESTART': '1', 03:06:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:16 INFO - 'PWD': '/builds/slave/test', 03:06:16 INFO - 'SHELL': '/bin/bash', 03:06:16 INFO - 'SHLVL': '1', 03:06:16 INFO - 'TERM': 'linux', 03:06:16 INFO - 'TMOUT': '86400', 03:06:16 INFO - 'USER': 'cltbld', 03:06:16 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1500800524.142068-1259549072', 03:06:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:16 INFO - '_': '/tools/buildbot/bin/python'} 03:06:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:16 INFO - Downloading/unpacking psutil>=3.1.1 03:06:16 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:06:16 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:06:16 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:06:16 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:06:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:06:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:06:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:06:17 INFO - Installing collected packages: psutil 03:06:17 INFO - Running setup.py install for psutil 03:06:17 INFO - building 'psutil._psutil_linux' extension 03:06:17 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:06:17 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:06:17 INFO - building 'psutil._psutil_posix' extension 03:06:17 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:06:18 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:06:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:06:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:06:18 INFO - Successfully installed psutil 03:06:18 INFO - Cleaning up... 03:06:18 INFO - Return code: 0 03:06:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:06:18 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:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:18 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:06:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:18 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 0xc2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf99eb0>, '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 0xf9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9b240>, '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': '826874ccc97bd7bf541b4875000001d5-1500800524.142068-1259549072', '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:06:18 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:06:18 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:06:18 INFO - Using env: {'DISPLAY': ':0', 03:06:18 INFO - 'HOME': '/home/cltbld', 03:06:18 INFO - 'LANG': 'en_US.UTF-8', 03:06:18 INFO - 'LANGUAGE': 'en_US:en', 03:06:18 INFO - 'LOGNAME': 'cltbld', 03:06:18 INFO - 'MAIL': '/var/mail/cltbld', 03:06:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:18 INFO - 'MOZ_NO_REMOTE': '1', 03:06:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:18 INFO - 'NO_EM_RESTART': '1', 03:06:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:18 INFO - 'PWD': '/builds/slave/test', 03:06:18 INFO - 'SHELL': '/bin/bash', 03:06:18 INFO - 'SHLVL': '1', 03:06:18 INFO - 'TERM': 'linux', 03:06:18 INFO - 'TMOUT': '86400', 03:06:18 INFO - 'USER': 'cltbld', 03:06:18 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1500800524.142068-1259549072', 03:06:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:18 INFO - '_': '/tools/buildbot/bin/python'} 03:06:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:06:18 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:06:18 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:06:18 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:06:18 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:06:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:06:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:06:19 INFO - Installing collected packages: mozsystemmonitor 03:06:19 INFO - Running setup.py install for mozsystemmonitor 03:06:19 INFO - Successfully installed mozsystemmonitor 03:06:19 INFO - Cleaning up... 03:06:19 INFO - Return code: 0 03:06:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:06:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xc2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf99eb0>, '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 0xf9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9b240>, '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': '826874ccc97bd7bf541b4875000001d5-1500800524.142068-1259549072', '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:06:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:06:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:06:19 INFO - Using env: {'DISPLAY': ':0', 03:06:19 INFO - 'HOME': '/home/cltbld', 03:06:19 INFO - 'LANG': 'en_US.UTF-8', 03:06:19 INFO - 'LANGUAGE': 'en_US:en', 03:06:19 INFO - 'LOGNAME': 'cltbld', 03:06:19 INFO - 'MAIL': '/var/mail/cltbld', 03:06:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:19 INFO - 'MOZ_NO_REMOTE': '1', 03:06:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:19 INFO - 'NO_EM_RESTART': '1', 03:06:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:19 INFO - 'PWD': '/builds/slave/test', 03:06:19 INFO - 'SHELL': '/bin/bash', 03:06:19 INFO - 'SHLVL': '1', 03:06:19 INFO - 'TERM': 'linux', 03:06:19 INFO - 'TMOUT': '86400', 03:06:19 INFO - 'USER': 'cltbld', 03:06:19 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1500800524.142068-1259549072', 03:06:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:19 INFO - '_': '/tools/buildbot/bin/python'} 03:06:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:19 INFO - Downloading/unpacking jsonschema==2.5.1 03:06:19 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:06:19 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:06:19 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:06:19 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:06:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:06:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:21 INFO - Downloading functools32-3.2.3-2.tar.gz 03:06:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:06:21 INFO - warning: no files found matching '*.txt' 03:06:21 INFO - no previously-included directories found matching 'build' 03:06:21 INFO - no previously-included directories found matching 'dist' 03:06:21 INFO - no previously-included directories found matching '.git*' 03:06:21 INFO - Installing collected packages: jsonschema, functools32 03:06:21 INFO - Running setup.py install for functools32 03:06:21 INFO - warning: no files found matching '*.txt' 03:06:21 INFO - no previously-included directories found matching 'build' 03:06:21 INFO - no previously-included directories found matching 'dist' 03:06:21 INFO - no previously-included directories found matching '.git*' 03:06:21 INFO - Successfully installed jsonschema functools32 03:06:21 INFO - Cleaning up... 03:06:21 INFO - Return code: 0 03:06:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:06: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:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06: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:06:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:21 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 0xc2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf99eb0>, '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 0xf9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9b240>, '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': '826874ccc97bd7bf541b4875000001d5-1500800524.142068-1259549072', '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:06:21 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:06:21 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:06:21 INFO - Using env: {'DISPLAY': ':0', 03:06:21 INFO - 'HOME': '/home/cltbld', 03:06:21 INFO - 'LANG': 'en_US.UTF-8', 03:06:21 INFO - 'LANGUAGE': 'en_US:en', 03:06:21 INFO - 'LOGNAME': 'cltbld', 03:06:21 INFO - 'MAIL': '/var/mail/cltbld', 03:06:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:21 INFO - 'MOZ_NO_REMOTE': '1', 03:06:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:21 INFO - 'NO_EM_RESTART': '1', 03:06:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:21 INFO - 'PWD': '/builds/slave/test', 03:06:21 INFO - 'SHELL': '/bin/bash', 03:06:21 INFO - 'SHLVL': '1', 03:06:21 INFO - 'TERM': 'linux', 03:06:21 INFO - 'TMOUT': '86400', 03:06:21 INFO - 'USER': 'cltbld', 03:06:21 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1500800524.142068-1259549072', 03:06:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:21 INFO - '_': '/tools/buildbot/bin/python'} 03:06:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:06:21 INFO - Cleaning up... 03:06:21 INFO - Return code: 0 03:06:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:06: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:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06: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:06:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:21 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 0xc2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf99eb0>, '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 0xf9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9b240>, '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': '826874ccc97bd7bf541b4875000001d5-1500800524.142068-1259549072', '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:06:21 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:06:21 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:06:21 INFO - Using env: {'DISPLAY': ':0', 03:06:21 INFO - 'HOME': '/home/cltbld', 03:06:21 INFO - 'LANG': 'en_US.UTF-8', 03:06:21 INFO - 'LANGUAGE': 'en_US:en', 03:06:21 INFO - 'LOGNAME': 'cltbld', 03:06:21 INFO - 'MAIL': '/var/mail/cltbld', 03:06:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:21 INFO - 'MOZ_NO_REMOTE': '1', 03:06:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:21 INFO - 'NO_EM_RESTART': '1', 03:06:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:21 INFO - 'PWD': '/builds/slave/test', 03:06:21 INFO - 'SHELL': '/bin/bash', 03:06:21 INFO - 'SHLVL': '1', 03:06:21 INFO - 'TERM': 'linux', 03:06:21 INFO - 'TMOUT': '86400', 03:06:21 INFO - 'USER': 'cltbld', 03:06:21 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1500800524.142068-1259549072', 03:06:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:21 INFO - '_': '/tools/buildbot/bin/python'} 03:06:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:21 INFO - Downloading/unpacking blobuploader==1.2.4 03:06:21 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:06:21 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:06:21 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:06:21 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:06:22 INFO - Downloading blobuploader-1.2.4.tar.gz 03:06:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:06:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:06:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:06:23 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:06:23 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:06:23 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:06:23 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:06:23 INFO - Downloading docopt-0.6.1.tar.gz 03:06:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:06:23 INFO - Installing collected packages: blobuploader, requests, docopt 03:06:23 INFO - Running setup.py install for blobuploader 03:06:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:06:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:06:23 INFO - Running setup.py install for requests 03:06:23 INFO - Running setup.py install for docopt 03:06:23 INFO - Successfully installed blobuploader requests docopt 03:06:23 INFO - Cleaning up... 03:06:23 INFO - Return code: 0 03:06:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:06:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:23 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 0xc2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf99eb0>, '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 0xf9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9b240>, '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': '826874ccc97bd7bf541b4875000001d5-1500800524.142068-1259549072', '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:06:23 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:06:23 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:06:23 INFO - Using env: {'DISPLAY': ':0', 03:06:23 INFO - 'HOME': '/home/cltbld', 03:06:23 INFO - 'LANG': 'en_US.UTF-8', 03:06:23 INFO - 'LANGUAGE': 'en_US:en', 03:06:23 INFO - 'LOGNAME': 'cltbld', 03:06:23 INFO - 'MAIL': '/var/mail/cltbld', 03:06:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:23 INFO - 'MOZ_NO_REMOTE': '1', 03:06:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:23 INFO - 'NO_EM_RESTART': '1', 03:06:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:23 INFO - 'PWD': '/builds/slave/test', 03:06:23 INFO - 'SHELL': '/bin/bash', 03:06:24 INFO - 'SHLVL': '1', 03:06:24 INFO - 'TERM': 'linux', 03:06:24 INFO - 'TMOUT': '86400', 03:06:24 INFO - 'USER': 'cltbld', 03:06:24 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1500800524.142068-1259549072', 03:06:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:24 INFO - '_': '/tools/buildbot/bin/python'} 03:06:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:06:24 INFO - Running setup.py (path:/tmp/pip-RpSt_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:06:24 INFO - Running setup.py (path:/tmp/pip-cVWpWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:06:24 INFO - Running setup.py (path:/tmp/pip-ODtTY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:06:24 INFO - Running setup.py (path:/tmp/pip-EOmvIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:06:24 INFO - Running setup.py (path:/tmp/pip-E6ZLXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:06:24 INFO - Running setup.py (path:/tmp/pip-09BrkM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:06:24 INFO - Running setup.py (path:/tmp/pip-H__xac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:06:24 INFO - Running setup.py (path:/tmp/pip-AykEaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:06:24 INFO - Running setup.py (path:/tmp/pip-deQTH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:06:24 INFO - Running setup.py (path:/tmp/pip-g64HnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:06:24 INFO - Running setup.py (path:/tmp/pip-a4qLn7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:06:25 INFO - Running setup.py (path:/tmp/pip-3t0kmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:06:25 INFO - Running setup.py (path:/tmp/pip-LTdOSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:06:25 INFO - Running setup.py (path:/tmp/pip-I14Yt9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:06:25 INFO - Running setup.py (path:/tmp/pip-znLX09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:06:25 INFO - Running setup.py (path:/tmp/pip-EAijew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:06:25 INFO - Running setup.py (path:/tmp/pip-27xH7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:06:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:06:25 INFO - Running setup.py install for manifestparser 03:06:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:06:25 INFO - Running setup.py install for mozcrash 03:06:25 INFO - Running setup.py install for mozdebug 03:06:25 INFO - Running setup.py install for mozdevice 03:06:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:06:25 INFO - Running setup.py install for mozfile 03:06:25 INFO - Running setup.py install for mozhttpd 03:06:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:06:26 INFO - Running setup.py install for mozinfo 03:06:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:06:26 INFO - Running setup.py install for mozInstall 03:06:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:06:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:06:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:06:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:06:26 INFO - Running setup.py install for mozleak 03:06:26 INFO - Running setup.py install for mozlog 03:06:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:06:26 INFO - Running setup.py install for moznetwork 03:06:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:06:26 INFO - Running setup.py install for mozprocess 03:06:26 INFO - Running setup.py install for mozprofile 03:06:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:06:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:06:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:06:26 INFO - Running setup.py install for mozrunner 03:06:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:06:26 INFO - Running setup.py install for mozscreenshot 03:06:26 INFO - Running setup.py install for moztest 03:06:27 INFO - Running setup.py install for mozversion 03:06:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:06:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:06:27 INFO - Cleaning up... 03:06:27 INFO - Return code: 0 03:06:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:06:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:27 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 0xc2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf99eb0>, '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 0xf9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9b240>, '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': '826874ccc97bd7bf541b4875000001d5-1500800524.142068-1259549072', '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:06:27 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:06:27 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:06:27 INFO - Using env: {'DISPLAY': ':0', 03:06:27 INFO - 'HOME': '/home/cltbld', 03:06:27 INFO - 'LANG': 'en_US.UTF-8', 03:06:27 INFO - 'LANGUAGE': 'en_US:en', 03:06:27 INFO - 'LOGNAME': 'cltbld', 03:06:27 INFO - 'MAIL': '/var/mail/cltbld', 03:06:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:27 INFO - 'MOZ_NO_REMOTE': '1', 03:06:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:27 INFO - 'NO_EM_RESTART': '1', 03:06:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:27 INFO - 'PWD': '/builds/slave/test', 03:06:27 INFO - 'SHELL': '/bin/bash', 03:06:27 INFO - 'SHLVL': '1', 03:06:27 INFO - 'TERM': 'linux', 03:06:27 INFO - 'TMOUT': '86400', 03:06:27 INFO - 'USER': 'cltbld', 03:06:27 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1500800524.142068-1259549072', 03:06:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:27 INFO - '_': '/tools/buildbot/bin/python'} 03:06:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:06:27 INFO - Running setup.py (path:/tmp/pip-3JNe7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:06:27 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:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:06:27 INFO - Running setup.py (path:/tmp/pip-HBlzWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:06:27 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:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:06:27 INFO - Running setup.py (path:/tmp/pip-wwbs7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:06:27 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:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:06:27 INFO - Running setup.py (path:/tmp/pip-Jrem9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:06:27 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:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:06:27 INFO - Running setup.py (path:/tmp/pip-wdIVXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:06:27 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:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:06:27 INFO - Running setup.py (path:/tmp/pip-Ka10oT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:06:27 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:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:06:27 INFO - Running setup.py (path:/tmp/pip-lWQ9po-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:06:27 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:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:06:27 INFO - Running setup.py (path:/tmp/pip-2RBOsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:06:27 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:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:06:28 INFO - Running setup.py (path:/tmp/pip-k_MpBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:06:28 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:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:06:28 INFO - Running setup.py (path:/tmp/pip-Yz75NN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:06:28 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:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:06:28 INFO - Running setup.py (path:/tmp/pip-QlVORB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:06:28 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:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:06:28 INFO - Running setup.py (path:/tmp/pip-hZCLZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:06:28 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:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:06:28 INFO - Running setup.py (path:/tmp/pip-zkhH58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:06:28 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:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:06:28 INFO - Running setup.py (path:/tmp/pip-p7ZIx8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:06:28 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:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:06:28 INFO - Running setup.py (path:/tmp/pip-unibYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:06:28 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:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:06:28 INFO - Running setup.py (path:/tmp/pip-M3gZKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:06:28 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:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:06:28 INFO - Running setup.py (path:/tmp/pip-_kmNeN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:06:28 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:06:28 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:06:28 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:06:28 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:06:28 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:06:28 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:06:28 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:06:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:29 INFO - Downloading blessings-1.6.tar.gz 03:06:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:06:29 INFO - Installing collected packages: blessings 03:06:29 INFO - Running setup.py install for blessings 03:06:29 INFO - Successfully installed blessings 03:06:29 INFO - Cleaning up... 03:06:29 INFO - Return code: 0 03:06:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:06:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:06:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:06:30 INFO - Reading from file tmpfile_stdout 03:06:30 INFO - Current package versions: 03:06:30 INFO - argparse == 1.2.1 03:06:30 INFO - blessings == 1.6 03:06:30 INFO - blobuploader == 1.2.4 03:06:30 INFO - docopt == 0.6.1 03:06:30 INFO - functools32 == 3.2.3-2 03:06:30 INFO - jsonschema == 2.5.1 03:06:30 INFO - manifestparser == 1.1 03:06:30 INFO - mozInstall == 1.13 03:06:30 INFO - mozcrash == 1.0 03:06:30 INFO - mozdebug == 0.1 03:06:30 INFO - mozdevice == 0.51 03:06:30 INFO - mozfile == 1.2 03:06:30 INFO - mozhttpd == 0.7 03:06:30 INFO - mozinfo == 0.10 03:06:30 INFO - mozleak == 0.1 03:06:30 INFO - mozlog == 3.5 03:06:30 INFO - moznetwork == 0.27 03:06:30 INFO - mozprocess == 0.25 03:06:30 INFO - mozprofile == 0.28 03:06:30 INFO - mozrunner == 6.13 03:06:30 INFO - mozscreenshot == 0.1 03:06:30 INFO - mozsystemmonitor == 0.3 03:06:30 INFO - moztest == 0.8 03:06:30 INFO - mozversion == 1.4 03:06:30 INFO - psutil == 3.1.1 03:06:30 INFO - requests == 1.2.3 03:06:30 INFO - wsgiref == 0.1.2 03:06:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:30 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 0xc2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf99eb0>, '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 0xf9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9b240>, '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': '826874ccc97bd7bf541b4875000001d5-1500800524.142068-1259549072', '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:06:30 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:06:30 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:06:30 INFO - Using env: {'DISPLAY': ':0', 03:06:30 INFO - 'HOME': '/home/cltbld', 03:06:30 INFO - 'LANG': 'en_US.UTF-8', 03:06:30 INFO - 'LANGUAGE': 'en_US:en', 03:06:30 INFO - 'LOGNAME': 'cltbld', 03:06:30 INFO - 'MAIL': '/var/mail/cltbld', 03:06:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:30 INFO - 'MOZ_NO_REMOTE': '1', 03:06:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:30 INFO - 'NO_EM_RESTART': '1', 03:06:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:30 INFO - 'PWD': '/builds/slave/test', 03:06:30 INFO - 'SHELL': '/bin/bash', 03:06:30 INFO - 'SHLVL': '1', 03:06:30 INFO - 'TERM': 'linux', 03:06:30 INFO - 'TMOUT': '86400', 03:06:30 INFO - 'USER': 'cltbld', 03:06:30 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1500800524.142068-1259549072', 03:06:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:30 INFO - '_': '/tools/buildbot/bin/python'} 03:06:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:30 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:06:30 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:06:30 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:06:30 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:06:30 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:06:30 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:06:30 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:06:30 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:06:30 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:06:30 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:31 INFO - Downloading marionette_driver-1.4.0.tar.gz 03:06:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 03:06:31 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 03:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:06:31 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:06:31 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:06:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:06:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:06:31 INFO - Installing collected packages: marionette-driver, simplejson 03:06:31 INFO - Running setup.py install for marionette-driver 03:06:31 INFO - Running setup.py install for simplejson 03:06:32 INFO - building 'simplejson._speedups' extension 03:06:32 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:06:32 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:06:32 INFO - Successfully installed marionette-driver simplejson 03:06:32 INFO - Cleaning up... 03:06:32 INFO - Return code: 0 03:06:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:06:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:32 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 0xc2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf99eb0>, '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 0xf9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9b240>, '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': '826874ccc97bd7bf541b4875000001d5-1500800524.142068-1259549072', '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:06:32 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:06:32 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:06:32 INFO - Using env: {'DISPLAY': ':0', 03:06:32 INFO - 'HOME': '/home/cltbld', 03:06:32 INFO - 'LANG': 'en_US.UTF-8', 03:06:32 INFO - 'LANGUAGE': 'en_US:en', 03:06:32 INFO - 'LOGNAME': 'cltbld', 03:06:32 INFO - 'MAIL': '/var/mail/cltbld', 03:06:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:32 INFO - 'MOZ_NO_REMOTE': '1', 03:06:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:32 INFO - 'NO_EM_RESTART': '1', 03:06:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:32 INFO - 'PWD': '/builds/slave/test', 03:06:32 INFO - 'SHELL': '/bin/bash', 03:06:32 INFO - 'SHLVL': '1', 03:06:32 INFO - 'TERM': 'linux', 03:06:32 INFO - 'TMOUT': '86400', 03:06:32 INFO - 'USER': 'cltbld', 03:06:32 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1500800524.142068-1259549072', 03:06:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:32 INFO - '_': '/tools/buildbot/bin/python'} 03:06:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:06:33 INFO - Cleaning up... 03:06:33 INFO - Return code: 0 03:06:33 INFO - Running post-action listener: _resource_record_post_action 03:06:33 INFO - Running post-action listener: _start_resource_monitoring 03:06:33 INFO - Starting resource monitoring. 03:06:33 INFO - [mozharness: 2017-07-23 10:06:33.212348Z] Finished create-virtualenv step (success) 03:06:33 INFO - [mozharness: 2017-07-23 10:06:33.212865Z] Running install step. 03:06:33 INFO - Running pre-action listener: _resource_record_pre_action 03:06:33 INFO - Running main action method: install 03:06:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:06:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:06:33 INFO - Reading from file tmpfile_stdout 03:06:33 INFO - Detecting whether we're running mozinstall >=1.0... 03:06:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:06:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:06:33 INFO - Reading from file tmpfile_stdout 03:06:33 INFO - Output received: 03:06:33 INFO - Usage: mozinstall [options] installer 03:06:33 INFO - Options: 03:06:33 INFO - -h, --help show this help message and exit 03:06:33 INFO - -d DEST, --destination=DEST 03:06:33 INFO - Directory to install application into. [default: 03:06:33 INFO - "/builds/slave/test"] 03:06:33 INFO - --app=APP Application being installed. [default: firefox] 03:06:33 INFO - mkdir: /builds/slave/test/build/application 03:06:33 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:06:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:06:51 INFO - Reading from file tmpfile_stdout 03:06:51 INFO - Output received: 03:06:51 INFO - /builds/slave/test/build/application/firefox/firefox 03:06:51 INFO - Running post-action listener: _resource_record_post_action 03:06:51 INFO - [mozharness: 2017-07-23 10:06:51.529879Z] Finished install step (success) 03:06:51 INFO - [mozharness: 2017-07-23 10:06:51.530136Z] Running setup-mitmproxy step. 03:06:51 INFO - Running pre-action listener: _resource_record_pre_action 03:06:51 INFO - Running main action method: setup_mitmproxy 03:06:51 INFO - Skipping: mitmproxy is not required 03:06:51 INFO - Running post-action listener: _resource_record_post_action 03:06:51 INFO - [mozharness: 2017-07-23 10:06:51.531274Z] Finished setup-mitmproxy step (success) 03:06:51 INFO - [mozharness: 2017-07-23 10:06:51.531498Z] Running run-tests step. 03:06:51 INFO - Running pre-action listener: _resource_record_pre_action 03:06:51 INFO - Running pre-action listener: _set_gcov_prefix 03:06:51 INFO - Running main action method: run_tests 03:06:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:06:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:06:51 INFO - Python 2.7.3 03:06:51 INFO - Return code: 0 03:06:51 INFO - grabbing minidump binary from tooltool 03:06: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:06:51 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 0xf99eb0>, '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 0xf9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9b240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:06:51 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:06:51 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:06:51 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:06:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:06:51 INFO - Return code: 0 03:06:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:06:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:06:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:06:51 INFO - ENV: RUST_BACKTRACE is now 1 03:06:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:06:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:06:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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:06:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-052 --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:06:51 INFO - Using env: {'DISPLAY': ':0', 03:06:51 INFO - 'HOME': '/home/cltbld', 03:06:51 INFO - 'LANG': 'en_US.UTF-8', 03:06:51 INFO - 'LANGUAGE': 'en_US:en', 03:06:51 INFO - 'LOGNAME': 'cltbld', 03:06:51 INFO - 'MAIL': '/var/mail/cltbld', 03:06:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:06:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:06:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:51 INFO - 'MOZ_NO_REMOTE': '1', 03:06:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:06:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:51 INFO - 'NO_EM_RESTART': '1', 03:06:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:51 INFO - 'PWD': '/builds/slave/test', 03:06:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:06:51 INFO - 'RUST_BACKTRACE': '1', 03:06:51 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:06:51 INFO - 'SHELL': '/bin/bash', 03:06:51 INFO - 'SHLVL': '1', 03:06:51 INFO - 'STYLO_FORCE_ENABLED': '1', 03:06:51 INFO - 'TERM': 'linux', 03:06:51 INFO - 'TMOUT': '86400', 03:06:51 INFO - 'USER': 'cltbld', 03:06:51 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1500800524.142068-1259549072', 03:06:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:51 INFO - '_': '/tools/buildbot/bin/python'} 03:06:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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:06:51 INFO - mozversion application_buildid: 20170723092615 03:06:51 INFO - mozversion application_changeset: c023ce417c98641c0dfacaaf236dcfdcb7794f88 03:06:51 INFO - mozversion application_display_name: Nightly 03:06:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:06:51 INFO - mozversion application_name: Firefox 03:06:51 INFO - mozversion application_remotingname: firefox 03:06:51 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:06:51 INFO - mozversion application_vendor: Mozilla 03:06:51 INFO - mozversion application_version: 56.0a1 03:06:51 INFO - mozversion platform_buildid: 20170723092615 03:06:51 INFO - mozversion platform_changeset: c023ce417c98641c0dfacaaf236dcfdcb7794f88 03:06:51 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:06:51 INFO - mozversion platform_version: 56.0a1 03:06:51 INFO - using testdate: 1500804411 03:06:51 INFO - actual date: 1500804411 03:06:51 INFO - starting webserver on 'localhost:52228' 03:06:51 INFO - SUITE-START | Running 2 tests 03:06:51 INFO - TEST-START | dromaeo_css 03:06:51 INFO - Initialising browser for dromaeo_css test... 03:06:51 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52228/getInfo.html -profile /tmp/tmpEk3ngc/profile 03:06:51 INFO - TEST-INFO | started process 9069 (/builds/slave/test/build/application/firefox/firefox http://localhost:52228/getInfo.html) 03:06:58 INFO - TEST-INFO | 9069: exit 0 03:06:58 INFO - Browser initialized. 03:06:58 INFO - Running cycle 1/1 for dromaeo_css test... 03:06:58 INFO - TEST-INFO | started process 9301 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEk3ngc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:07:09 INFO - PID 9301 | RSS: Main: 177201152 03:07:09 INFO - PID 9301 | 03:10:09 INFO - PID 9301 | Cycle 1(1): loaded http://localhost:52228/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52228/tests/dromaeo/cssquery-ext.html) 03:10:10 INFO - PID 9301 | RSS: Main: 182272000 03:10:10 INFO - PID 9301 | 03:13:12 INFO - PID 9301 | Cycle 1(1): loaded http://localhost:52228/tests/dromaeo/cssquery-ext.html (next: http://localhost:52228/tests/dromaeo/cssquery-jquery.html) 03:13:13 INFO - PID 9301 | RSS: Main: 181207040 03:13:13 INFO - PID 9301 | 03:16:14 INFO - PID 9301 | Cycle 1(1): loaded http://localhost:52228/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52228/tests/dromaeo/cssquery-mootools.html) 03:16:15 INFO - PID 9301 | RSS: Main: 182452224 03:16:15 INFO - PID 9301 | 03:19:17 INFO - PID 9301 | Cycle 1(1): loaded http://localhost:52228/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52228/tests/dromaeo/cssquery-prototype.html) 03:19:18 INFO - PID 9301 | RSS: Main: 181485568 03:19:18 INFO - PID 9301 | 03:22:21 INFO - PID 9301 | Cycle 1(1): loaded http://localhost:52228/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52228/tests/dromaeo/cssquery-yui.html) 03:22:22 INFO - PID 9301 | RSS: Main: 183005184 03:22:22 INFO - PID 9301 | 03:25:24 INFO - PID 9301 | Cycle 1(1): loaded http://localhost:52228/tests/dromaeo/cssquery-yui.html (next: http://localhost:52228/tests/dromaeo/cssquery-dojo.html) 03:25:24 INFO - PID 9301 | RSS: Main: 184819712 03:25:24 INFO - PID 9301 | 03:25:24 INFO - PID 9301 | __start_tp_report 03:25:24 INFO - PID 9301 | _x_x_mozilla_page_load 03:25:24 INFO - PID 9301 | _x_x_mozilla_page_load_details 03:25:24 INFO - PID 9301 | |i|pagename|runs| 03:25:24 INFO - PID 9301 | |0;dojo.html;3123.312871168342;3159.004913452261;3165.287810242695;3165.9366812663748;3183.5702180205667;5984.072468767337;6208.2550093988675;6213.906791398127;6215.689215539228;6226.533010024249;6040.456358927696;6131.8773624527485;6147.81556553303;6172.166757487737;6177.289611694645;5662.094064949609;5678.233438485813;5701.657900525961;5707.77168913243;5722.7424765885635;5760.452756988079;5781.075027995522;5783.942160578404;5797.36229014808;5797.420257974211;5657.179708942201;5716.228309178249;5737.627054241482;5744.109663002241;5752.108423194411;5523.171524271352;5624.465675760796;5628.26832511775;5711.628744131618;5752.108423194411;5601.495865372095;5665.943340566583;5668.291463567054;5684.54523638108;5695.829125126253;6007.098935159717;6087.756489740405;6114.205153330083;6140.723667434976;6150.954337762591;6415.294317625057;6524.445422139124;6524.575902566318;6598.802035938929;6612;6675.299093595151;6696.86606267872;6709.798706038827;6723.865522689568;6771.593704377704;6165.7533698652;6168.784092556783;6178.289496707846;6253.6247825131095;6264.7807326743805;6694.899576506356;6791.898121528181;6808.761693340808;6914.619695916773;6915.377616014583;6458.773942911976;6532.281449040602;6546.312637173029;6558.737650493927;6565.277819439858;6600.933990660128;6610.4711623071;6616.636085015371;6659.167604049494;6698.5980841149685;6402.103705481236;6559.573627714183;6563.540552161398;6617.834554136089;6666.033425153326;6466.385693359123;6486.027095935648;6487.870242595121;6489.156409666713;6498.187726534184;5249.658772179796;5250.343707036621;5267.2889159962915;5333.173358129496;5341.813036543703;4484.8430304939175;4532.7280363178315;4585.060062687141;4607.35497030416;4620.145273124483;5693.544516438675;5837.708114594253;5839.854003649943;5846.035404158351;5848.678322692293;6653.866922661519;6672.466202703772;6684.331566843374;6762.864742705118;6785.321467853274;5599.860003499945;5667.858303542444;5693.914591281134;5755.85610359736;5764;5718.085106382959;5723.313202415654;5727;5728.742206600713;5729.341125770507;6370.904436433365;6406.67966601668;6424.743010279536;6425.871482570323;6469.676516174267;6556.3443655634055;6693.966530167513;6733.797986060426;6744.123263975652;6770.32296770319;6406.967965160145;6407.647579382992;6423.518236132402;6512.772052978313;6531.150950376421;6322.905156422749;6401.807945761635;6403.4877209824035;6409.647469389229;6552.6068435894;6686.364795344434;6718.630475323904;6737.393634572912;6738.427233685192;6783.966080169567;6466.0300954855265;6473.320301368289;6533.738650454119;6549.770758023446;6550.6069635822005;6344.143540622142;6457.321981192095;6546.574472659262;6546.934530654823;6551.4103730664465;6301.527385446018;6344.555881088279;6423.29343772194;6425.614463132227;6438.6136831790245;6438.678066096582;6494.350564943468;6510.804675859732;6511.967440162769;6558.573692709959;6182.319944805978;6190.659513726789;6234.314225435289;6293.339199383999;6359.618422894641 03:25:24 INFO - PID 9301 | |1;ext.html;833.6582001379436;864.0970186155467;889.4752096263203;1166.836642869999;1187;39775.40336894945;42986;43384.56615433845;43465.565344346585;43545.78227108868;43410.34884476735;43718.56281437185;43798.34302485465;43865.34201986965;43874.78062609683;7475.700971961115;7516.910048043031;7521.962390188069;7523.285287897641;7557.659905304261;7417.443691723115;7510.324070833624;7511.887321690179;7517.699292028312;7518.248175182465;7516.210797866227;7547.28300811422;7549.35830454412;7550.811229719274;7553.433492488058;7512;7517.0227870376775;7517.248275172494;7519.436042296822;7519.624018799038;7519.699212031513;7576.318131368148;7580.355669768076;7581.2418758124295;7582.279683430065;39621.80189099036;39788.60211397907;39841.80079099586;39877.60122398768;39939.20121597581;3612.710983121344;3657.524521812147;3662.1393972416463;3664.6152154023976;3669.834857431422;31580.684193158235;31637.52543711846;31662;31754.206144846332;31787.523187152212;4583.243764778807;4735.242361222188;4738.502457242009;4784.832530861438;4792.472827988919;178744;179384;179979;180029.9999999987;180431;49105.50894491009;49366.25950610744;49396.259056114184;49921;50801.237981430306;51783.22325165125;51818.74090629523;51822.74088629608;51919.221211681855;51947.74026129845;14160.716785664228;14227.64430889236;14247.715045699028;14815.777763333559;15370.923145384202;12070.27578345302;12387.380630968595;12390.504379824706;12393.380330983415;12400.379981000913;14918.328675209425;14985.32566034531;15031.624209394633;15103;15185.164815935008;5822.417758224144;5822.9138556565085;5872.590578261186;5882.1470886722045;6039;963.6868017894212;978.5987745024506;997.7655251016006;1006.2201793609864;1006.3257617396362;22519.43701407445;22902.885485572464;22988.88505557495;23029.654555181685;23341;1076.434871692352;1083.4474418046852;1101.5593762495066;1107.5569772091228;1116.0959622705634;12284.324362160167;12637.620871373874;16250.9436886602;16499.83500164983;16927;227842;228027;228063;228648;230114;60846.69576652088;60976.390236097955;61164.69417652972;61378;61602.69198653978;1433.8924580656285;1461.7661174212287;1479.578320178744;1490.0687070580886;1493.8804895608325;26834.59748103741;27492.45015099647;27511.58732618972;27558.86220568884;27701.722982769916;39556.80221598873;39725.60274397219;39860.20279594334;39890.20219595534;39924.40113398359;208832;210452;210575;210786;210892;34593.135171619906;35272.294554109285;35516.11209719778;35620.82189589035;35835;43537.78231108824;44872.32691509565;45041.54958450374;45152.548474514835;45535.77232113818;30333.241668958453;32333.676663233065;32584.83707581447;32823.835880821396;32859.50710739389;31931.521027184146;32086.518702219953;32132;32522.67477325291;32788;35052.12369690676;35271.294574108884;35443.11392215112;35748.28503429969;35900.8204958984;26304.868475658266;28780;28942.421151577273;29155.979540715973;29228;21234.256801011892;23690.28929132129;23695;23784.524309513366;23911.52176956486 03:25:24 INFO - PID 9301 | |2;jquery.html;570.3384074473612;598.3119412675422;600.2796644027163;603.6921170203195;618.9783357582486;21959.780402195975;22213.444663883412;23217.883910580465;23299.417514562123;23342.949567269494;25714.871425642847;26410;26437.07470238542;26506.602400964002;26645.600315995274;6476.514261430388;6613.041109039186;6644.169478815148;6644.833879153011;6645.800625981228;5867.618604790675;6455.7094930728;6481.416672499474;6496;6499.220093588776;6465.385788350122;6468.385503377195;6469.4500967417825;6470.482361411099;6474.028895665664;6462.547621666486;6465.709043093072;6466.191726034246;6470.611763294218;6471.902921456159;6024.728887200043;6033.064874944391;6035.943709850759;6040.728167232485;6045.153678485016;29024.854875725698;30031.69968300311;30075.097747067623;30278.394432111454;30590.84704576485;1891.6595012897674;1924.4130540185238;1938.932137375185;1939.21461807968;1939.8351140153104;18781.90609046946;18798;19089.23643054276;19241.326553570558;19289.131989060526;2272.397814579138;2286.8513546619415;2295.116380193621;2295.8622482650926;2307.757685443038;135710;137758;137827;138403.30798346046;138928;14225;14797;14862.13584468046;14964.551063468114;15488.457903973533;23724.169654062025;23836.16573419922;23842.761572384403;23854.761452385254;23859.522809543712;9924.801503970024;9992.80014399708;10029.147522460527;10160.949195253976;10205.846912296322;8327.833443331221;9232.907670923205;9313.580888860017;9362.391444556082;9439.858402123973;8124.675012999532;8948.68679596211;9060.184583387527;9063.81872362549;9500.95249523748;2571.344307201689;2629.9236183914854;2649.1125472966773;2689.5831146172372;2715.2804506805714;917.1653795046476;918.3296193778579;933.3093510801957;941.110650435332;949.4635530925005;18820.435386938414;19172.137253823334;19490;19699.704504432444;19806.504837378892;977.9951100244454;1007.924405669563;1012.3015119567475;1037.1702637889657;1049.842523621463;10551.84172237417;10703.197260205516;10871.510782014828;10903.29128606638;11019.669409917715;451816.70458238805;463413;465896;471027;473693;112780;114888;115234.42382788032;116693;117837;1274.6749578857332;1285.2930888011556;1292.101989117573;1293.6054503376372;1297.007789041384;16409.91795041017;17545.56136096608;17713.468595942144;17724.734128987817;17766.555836104202;52368.73815630897;52806.471935280155;53417.198742019675;54966.72516637551;55138;70449.29550704427;70848;70871;71100;71570.28429715845;14592.197429141499;14668.119912805267;14806.185659788815;14820;14872.479463219168;22664.320070397913;22720.318390448312;22948.541029179658;23130.53738925246;23226.187083451998;17840.3755868544;18059;18119.184636691643;18181.909085454914;18192.181351838935;13791.724165516835;14372.86103269974;14944;15447.691046178788;15800.130992795506;18344.816551834843;18382.908085459487;18665.066746662884;18699.34552290663;18752.906235468734;13925.930370348084;13981.790273146114;14111.364988575744;14141;14235.074720143157;17575.82424175793;18115.54711132232;18202.817971820114;18209.362672306404;18235 03:25:24 INFO - PID 9301 | |3;mootools.html;1332.0475859760272;1401.8598140185977;1402.649337665583;1405.6345350208942;1419.7941298511723;13476.932615336922;13944;14068.64828379291;14070.929645351758;14138.929305353471;13658.317084145803;14270.072445291049;14704.779428308584;14714.337854796533;14765.557033288991;2541.288439237012;2611.621314909337;2622.344413896526;2623.2261482862505;2626.4484458263787;2550.4261541153187;2610.0864697355964;2676.8661566921674;2680.557707978181;2693.4343787804582;2670;2702.540568103417;2710.254679963016;2716.3209197700576;2721.8366897986084;2528.2920782180927;2561.4108754986364;2617.947641047178;2675.1573254424793;2679.69183543893;2435.805135589166;2458.40998160442;2467.0625162438337;2561.474897645978;2615.5161295160456;13760.793588096187;13892.16647001183;13929.233892135928;13933;13948.442062317496;7212.8557428851655;7452.701891924316;7460.888086678704;7484.027076480077;7494.850102997964;4883.560479556857;5085.338905942203;5205.557527610158;5245.291885595434;5250.789968401259;1788.919498622565;1814.2742902838838;1820.2718912435;1848.1036697201846;1880.1633273193434;21656.35030949074;21970.670439943413;22000;22026.669599956014;22073.779262207332;6418.614883106935;6506.772262970773;6510.967445162744;6614.470842332602;6739.326067393222;14982.40070397172;15065.397384104514;15099.698006039818;15109.773353399707;15119.244037798066;7224.67488962998;7315.195328513859;7331.706731730777;7362.263773622702;7364.77905662831;6689.09697190873;6704.396604305538;6800.455963522906;6844.1444819397575;6903.585784852925;4889.364382630235;4944.1100601891285;4951.059298733229;4990.850274491771;5021.372328458942;1174.3130268792681;1197.3055627735891;1364.461037890028;1377.5454100146928;1442.163545143814;825.7110011495928;832.4713806732768;855.683397143061;863.8617821148586;883.7348795361495;7020.7542736004;7116.181639111465;7122.465815063891;7148.821279467951;7173.5337203081635;954.5847556313026;962.3985009369144;972.8589354543693;989;1008.996048931318;4296.871093867189;4631.91150079731;4798.328234047236;4853.514648535118;4984.277279794482;18495.44513664592;18771.812281877006;19070.904645476683;19081.90459047696;19097;17938.55153621144;18526.16632251552;18737.531561711065;18798.436046918614;18853.434396968114;9951.800963980824;10425.635102771366;10461.895381046397;10466.895331046744;10491.580336786596;7348.1182258129365;7628.80927976805;7825.647845847065;7900.881486777818;7928.7621371358955;15877.444289449813;16197.51407457778;16440.260188291315;16594;16777.748333774758;16251.756223656892;16640.084795336374;16807.41174058902;16820.663586728442;16922.915385422995;10914.890851091704;11076.5569377224;11077.667669969915;11090.390028548507;11133.053690436403;12509.937450312691;12569.120161588968;12583.811242831182;12681;12762;9358.578863951274;9570.090841370058;9743.512824358895;10127.341722787995;10484.842727359248;9620;10130.797384052425;10154.796904062025;10221.182305415698;10458.163346932379;9297.395669281475;9346.20557252641;9353.719388418358;9359.953200233955;9413.717588472357;6751.257361690308;6751.392374686302;7103.857922841617;7210.351068403659;7234.240404757425;7160.57036577807;7181.533200341961;7265.782026539212;7304.561726296439;7364.852702946018 03:25:24 INFO - PID 9301 | |4;prototype.html;483.4536973220262;488.6554978739991;512.7026324731656;518.911784996551;519.7609099814085;5991.880162396749;6220.44016038557;6232.563720539564;6256.6871656417225;6295.1816263885685;6003.639781613096;6026.69866506674;6087.878242435148;6088.604240724361;6144.969275153618;4871;4897.265410188465;4940.950590494094;4942.505749425065;4960.875978100558;4697.741624210667;4911.386076740408;4950.6287028472825;4952.479989601094;4994.97502512487;4859.757012149378;4860.829870954517;4880.341153944225;4910.386201724785;4935.5804756595735;4833;4836.274558816171;4857.514248575149;4919.720872573139;4936.925946110811;4355.760433176174;4402.2296098183015;4449.3548435477;4467.1735728889935;4475.172093162775;5994.310654274727;6009.1587177795145;6034.607750496204;6069.241344831896;6082.787102451437;5537.418571050062;5619.971900140514;5622.32532096151;5630.521405680522;5643.915341269884;6454.709538070798;6481.675916204218;6517.523341130388;6570.8028759137305;6577.736890524373;4823.155947709137;4867.9269810952865;4890.877728056791;4905.23968784839;4932.778024988848;6820.522563420563;6826.4538836892925;6844.384005439534;6873.347032031949;6899.793006209771;4972.726500042532;4988.90022199554;4996.925046124311;5025.321581586512;5027.296178535008;5017.37282839645;5048.066107770074;5054.49455054499;5062.7468626568525;5080.415752188472;5575.247341608912;5583.274174357389;5601.607887447921;5642.915356269659;5673.3475650299915;6433.228012638419;6452.451541619015;6469.935300646934;6500.219973603198;6587.670616469158;1642.5318784146461;1693.4242357598475;1706.3686436018504;1732.3070771691173;1743.8256174382714;1211.1098342718094;1226.6381417481864;1244.4151248912997;1250.3623152192447;1256.1646505074207;5520.806771762969;5533;5639.152228124771;5642.858928526737;5668.291463567054;6252.781152659635;6528.54300198991;6536.24833144185;6569.67151642416;6728.6635668216395;5657.6322539035655;5674.687237699378;5690.886182276331;5694.629849059798;5716.685582293014;3507.6846182681493;3521.7006554442646;3539.433690609542;3543.8759643412873;3546.2375589248436;6375.872482550323;6379.681015949277;6407;6509.772157974448;6519.674016299166;6751.729930802811;6847.726090956306;6871.5189936703955;6872;6882.311768823078;6381.329960354096;6407.9814858320415;6478.125453063776;6478.157839480931;6495.388274325188;6574.704138313883;6637.203535575762;6647.036179753812;6683.43190828785;6695.4978376620975;6490.772822951174;6555.2133743949125;6586.090033890118;6588.978708300221;6594.472442204708;6253.999360102362;6343.143675603919;6363.268224154282;6401.391867772554;6488.513361497812;4932.161532539405;4936;4949.950500494949;4973.204287314013;4987.775550100182;6629.933700662931;6648.5678430901835;6686.866262674622;6690.026442199465;6695.263521012587;6477.967610161919;6498;6541.757066157415;6563.901541476977;6565.80302590923;6295.748170073146;6329.417405897815;6370.6814659267775;6400.263969643551;6409.262934762375;6019.277686677627;6145.9692701536205;6228.190335256388;6236.18929539157;6300;6325.96837015812;6391.794830783372;6496.220453545605;6518.706658200297;6532.738690452328;6254.186955695731;6260.373962603703;6295.244570651551;6304.71628776697;6309.873802524015 03:25:24 INFO - PID 9301 | |5;yui.html;895.7715782475468;913.9131782480662;914.5015966298366;917.3945196170529;926.8517037274036;17734.113294335297;18573.257069717194;18665.4400367989;18724.719129213056;21052.473688157803;19577.51056223595;20298.086586103625;20302.89848550759;20379.592408151828;20387.08258128384;1031.128696251668;1045.796069766396;1046.9895301046968;1049.942253176075;1050.0129877914735;965.1217392173124;1041.828098363769;1041.953112109957;1043.5929987304958;1053.1995683280722;1077.7359546911018;1111.6276047524088;1113.3041848844473;1115.3865374044244;1116.2019156303243;1103.4979084516526;1104.0229396983648;1104.536094840169;1105.723569107723;1115.4534278203662;810.4124509730457;811.4887620798859;812.001238476677;812.9512229266263;816.8652172391548;18385.356512522132;19117.330893418803;19452;19485.805141948542;19546.609067818565;20071.297504587415;20378.082986265654;20467.48831279215;21061.47346316339;21074.78925210759;15513.534593962198;15574.299156537983;15658.608534786608;15672.529824105295;16035.198240088066;3535.381308271042;3543.982280088609;3552.6980206682465;3556.78659280444;3565.286942611462;113736;119143;120361;125281;127934.36032819869;15955.361785528681;16218;16446.259918303705;16998.915005424893;17046.659066818593;29145.854270728512;30442.086737397913;30506;30551;30714;7265.491415600963;7559.697612095564;8127.59362031896;8266.958665206635;8505.404621676547;4069.7151199415757;4194.475690538683;4206.537280899099;4207.495100587949;4220.198162349206;4638.443386793539;4761.761911904391;4806.807727690853;4808.2787581863;4868.2210846264425;1042.8175069362983;1052.9210309226685;1055.7307886488895;1056.7569459024314;1056.99471502642;654.2933631677777;676.1953275602018;700.0304578159286;700.2087640965676;707.734599525178;11460.09253615003;11543.249688770204;11640.01059909917;11959.820602690967;12291;668.6355936014884;701.8455939693259;702.7926761605339;706.3713295167305;719.4388377065897;5028.924566131511;5298.311219541435;5361.544268737123;5472.20653005312;5594.1888426177975;92830;95288;95530.52234738921;100657.49671251743;100981;86223.56888215519;88244;89578;91971;93746.53126734459;72408.27591724016;74307;77120.61439692878;77863.61068194623;78159.21840781633;10957.56169753201;10987;11162;11317.603883864025;11583.536658533565;32823.507647385784;33555.83222083874;36461.45307820438;37000.25999480049;37538.436923446716;43150.568494314655;44765.552344477444;46459;46722.29916551187;47204.291935620306;15425.228738563252;15918.124503152438;15939.123348215959;15973.520794376187;15986.280617372013;15871.28579213915;17081.572960676083;17386.913065434594;17922.372716954844;18033.1885065175;17498.475045748648;17596.472105836845;17789.37737179244;17799;17848.821511784718;17398;17473.650526989644;17475.737863931798;17518.211680474666;17592.38426655061;17937.910310448366;18075.186616602547;18147.637047259246;18181.818181818013;18241.817581824544;13194.80207796903;13278.468861245441;13619.250941197934;13725.519606813714;13785.931070344584;13393.464261429433;13482.258475783927;13502;13521.323933803467;13665.79501307501 03:25:24 INFO - PID 9301 | __end_tp_report 03:25:24 INFO - PID 9301 | __start_cc_report 03:25:24 INFO - PID 9301 | _x_x_mozilla_cycle_collect,381 03:25:24 INFO - PID 9301 | __end_cc_report 03:25:24 INFO - PID 9301 | __startTimestamp1500805524689__endTimestamp 03:25:24 INFO - PID 9301 | 03:25:24 INFO - PID 9301 | ------- Summary: start ------- 03:25:24 INFO - PID 9301 | Number of tests: 6 03:25:24 INFO - PID 9301 | 03:25:24 INFO - PID 9301 | [#0] dojo.html Cycles:165 Average:6098.37 Median:6344.56 stddev:718.81 (11.3%) stddev-sans-first:682.08 03:25:24 INFO - PID 9301 | Values: 3123.3 3159.0 3165.3 3165.9 3183.6 5984.1 6208.3 6213.9 6215.7 6226.5 6040.5 6131.9 6147.8 6172.2 6177.3 5662.1 5678.2 5701.7 5707.8 5722.7 5760.5 5781.1 5783.9 5797.4 5797.4 5657.2 5716.2 5737.6 5744.1 5752.1 5523.2 5624.5 5628.3 5711.6 5752.1 5601.5 5665.9 5668.3 5684.5 5695.8 6007.1 6087.8 6114.2 6140.7 6151.0 6415.3 6524.4 6524.6 6598.8 6612.0 6675.3 6696.9 6709.8 6723.9 6771.6 6165.8 6168.8 6178.3 6253.6 6264.8 6694.9 6791.9 6808.8 6914.6 6915.4 6458.8 6532.3 6546.3 6558.7 6565.3 6600.9 6610.5 6616.6 6659.2 6698.6 6402.1 6559.6 6563.5 6617.8 6666.0 6466.4 6486.0 6487.9 6489.2 6498.2 5249.7 5250.3 5267.3 5333.2 5341.8 4484.8 4532.7 4585.1 4607.4 4620.1 5693.5 5837.7 5839.9 5846.0 5848.7 6653.9 6672.5 6684.3 6762.9 6785.3 5599.9 5667.9 5693.9 5755.9 5764.0 5718.1 5723.3 5727.0 5728.7 5729.3 6370.9 6406.7 6424.7 6425.9 6469.7 6556.3 6694.0 6733.8 6744.1 6770.3 6407.0 6407.6 6423.5 6512.8 6531.2 6322.9 6401.8 6403.5 6409.6 6552.6 6686.4 6718.6 6737.4 6738.4 6784.0 6466.0 6473.3 6533.7 6549.8 6550.6 6344.1 6457.3 6546.6 6546.9 6551.4 6301.5 6344.6 6423.3 6425.6 6438.6 6438.7 6494.4 6510.8 6512.0 6558.6 6182.3 6190.7 6234.3 6293.3 6359.6 03:25:24 INFO - PID 9301 | 03:25:24 INFO - PID 9301 | [#1] ext.html Cycles:180 Average:38182.77 Median:35684.55 stddev:53766.92 (150.7%) stddev-sans-first:53844.61 03:25:24 INFO - PID 9301 | Values: 833.7 864.1 889.5 1166.8 1187.0 39775.4 42986.0 43384.6 43465.6 43545.8 43410.3 43718.6 43798.3 43865.3 43874.8 7475.7 7516.9 7522.0 7523.3 7557.7 7417.4 7510.3 7511.9 7517.7 7518.2 7516.2 7547.3 7549.4 7550.8 7553.4 7512.0 7517.0 7517.2 7519.4 7519.6 7519.7 7576.3 7580.4 7581.2 7582.3 39621.8 39788.6 39841.8 39877.6 39939.2 3612.7 3657.5 3662.1 3664.6 3669.8 31580.7 31637.5 31662.0 31754.2 31787.5 4583.2 4735.2 4738.5 4784.8 4792.5 178744.0 179384.0 179979.0 180030.0 180431.0 49105.5 49366.3 49396.3 49921.0 50801.2 51783.2 51818.7 51822.7 51919.2 51947.7 14160.7 14227.6 14247.7 14815.8 15370.9 12070.3 12387.4 12390.5 12393.4 12400.4 14918.3 14985.3 15031.6 15103.0 15185.2 5822.4 5822.9 5872.6 5882.1 6039.0 963.7 978.6 997.8 1006.2 1006.3 22519.4 22902.9 22988.9 23029.7 23341.0 1076.4 1083.4 1101.6 1107.6 1116.1 12284.3 12637.6 16250.9 16499.8 16927.0 227842.0 228027.0 228063.0 228648.0 230114.0 60846.7 60976.4 61164.7 61378.0 61602.7 1433.9 1461.8 1479.6 1490.1 1493.9 26834.6 27492.5 27511.6 27558.9 27701.7 39556.8 39725.6 39860.2 39890.2 39924.4 208832.0 210452.0 210575.0 210786.0 210892.0 34593.1 35272.3 35516.1 35620.8 35835.0 43537.8 44872.3 45041.5 45152.5 45535.8 30333.2 32333.7 32584.8 32823.8 32859.5 31931.5 32086.5 32132.0 32522.7 32788.0 35052.1 35271.3 35443.1 35748.3 35900.8 26304.9 28780.0 28942.4 29156.0 29228.0 21234.3 23690.3 23695.0 23784.5 23911.5 03:25:24 INFO - PID 9301 | 03:25:24 INFO - PID 9301 | [#2] jquery.html Cycles:180 Average:33881.78 Median:2301.81 stddev:78758.34 (3421.6%) stddev-sans-first:78939.56 03:25:24 INFO - PID 9301 | Values: 570.3 598.3 600.3 603.7 619.0 21959.8 22213.4 23217.9 23299.4 23342.9 25714.9 26410.0 26437.1 26506.6 26645.6 6476.5 6613.0 6644.2 6644.8 6645.8 5867.6 6455.7 6481.4 6496.0 6499.2 6465.4 6468.4 6469.5 6470.5 6474.0 6462.5 6465.7 6466.2 6470.6 6471.9 6024.7 6033.1 6035.9 6040.7 6045.2 29024.9 30031.7 30075.1 30278.4 30590.8 1891.7 1924.4 1938.9 1939.2 1939.8 18781.9 18798.0 19089.2 19241.3 19289.1 2272.4 2286.9 2295.1 2295.9 2307.8 135710.0 137758.0 137827.0 138403.3 138928.0 14225.0 14797.0 14862.1 14964.6 15488.5 23724.2 23836.2 23842.8 23854.8 23859.5 9924.8 9992.8 10029.1 10160.9 10205.8 8327.8 9232.9 9313.6 9362.4 9439.9 8124.7 8948.7 9060.2 9063.8 9501.0 2571.3 2629.9 2649.1 2689.6 2715.3 917.2 918.3 933.3 941.1 949.5 18820.4 19172.1 19490.0 19699.7 19806.5 978.0 1007.9 1012.3 1037.2 1049.8 10551.8 10703.2 10871.5 10903.3 11019.7 451816.7 463413.0 465896.0 471027.0 473693.0 112780.0 114888.0 115234.4 116693.0 117837.0 1274.7 1285.3 1292.1 1293.6 1297.0 16409.9 17545.6 17713.5 17724.7 17766.6 52368.7 52806.5 53417.2 54966.7 55138.0 70449.3 70848.0 70871.0 71100.0 71570.3 14592.2 14668.1 14806.2 14820.0 14872.5 22664.3 22720.3 22948.5 23130.5 23226.2 17840.4 18059.0 18119.2 18181.9 18192.2 13791.7 14372.9 14944.0 15447.7 15800.1 18344.8 18382.9 18665.1 18699.3 18752.9 13925.9 13981.8 14111.4 14141.0 14235.1 17575.8 18115.5 18202.8 18209.4 18235.0 03:25:24 INFO - PID 9301 | 03:25:24 INFO - PID 9301 | [#3] mootools.html Cycles:180 Average:8461.69 Median:2613.57 stddev:5737.50 (219.5%) stddev-sans-first:5728.58 03:25:24 INFO - PID 9301 | Values: 1332.0 1401.9 1402.6 1405.6 1419.8 13476.9 13944.0 14068.6 14070.9 14138.9 13658.3 14270.1 14704.8 14714.3 14765.6 2541.3 2611.6 2622.3 2623.2 2626.4 2550.4 2610.1 2676.9 2680.6 2693.4 2670.0 2702.5 2710.3 2716.3 2721.8 2528.3 2561.4 2617.9 2675.2 2679.7 2435.8 2458.4 2467.1 2561.5 2615.5 13760.8 13892.2 13929.2 13933.0 13948.4 7212.9 7452.7 7460.9 7484.0 7494.9 4883.6 5085.3 5205.6 5245.3 5250.8 1788.9 1814.3 1820.3 1848.1 1880.2 21656.4 21970.7 22000.0 22026.7 22073.8 6418.6 6506.8 6511.0 6614.5 6739.3 14982.4 15065.4 15099.7 15109.8 15119.2 7224.7 7315.2 7331.7 7362.3 7364.8 6689.1 6704.4 6800.5 6844.1 6903.6 4889.4 4944.1 4951.1 4990.9 5021.4 1174.3 1197.3 1364.5 1377.5 1442.2 825.7 832.5 855.7 863.9 883.7 7020.8 7116.2 7122.5 7148.8 7173.5 954.6 962.4 972.9 989.0 1009.0 4296.9 4631.9 4798.3 4853.5 4984.3 18495.4 18771.8 19070.9 19081.9 19097.0 17938.6 18526.2 18737.5 18798.4 18853.4 9951.8 10425.6 10461.9 10466.9 10491.6 7348.1 7628.8 7825.6 7900.9 7928.8 15877.4 16197.5 16440.3 16594.0 16777.7 16251.8 16640.1 16807.4 16820.7 16922.9 10914.9 11076.6 11077.7 11090.4 11133.1 12509.9 12569.1 12583.8 12681.0 12762.0 9358.6 9570.1 9743.5 10127.3 10484.8 9620.0 10130.8 10154.8 10221.2 10458.2 9297.4 9346.2 9353.7 9360.0 9413.7 6751.3 6751.4 7103.9 7210.4 7234.2 7160.6 7181.5 7265.8 7304.6 7364.9 03:25:24 INFO - PID 9301 | 03:25:24 INFO - PID 9301 | [#4] prototype.html Cycles:180 Average:5441.57 Median:6030.65 stddev:1523.97 (25.3%) stddev-sans-first:1482.11 03:25:24 INFO - PID 9301 | Values: 483.5 488.7 512.7 518.9 519.8 5991.9 6220.4 6232.6 6256.7 6295.2 6003.6 6026.7 6087.9 6088.6 6145.0 4871.0 4897.3 4941.0 4942.5 4960.9 4697.7 4911.4 4950.6 4952.5 4995.0 4859.8 4860.8 4880.3 4910.4 4935.6 4833.0 4836.3 4857.5 4919.7 4936.9 4355.8 4402.2 4449.4 4467.2 4475.2 5994.3 6009.2 6034.6 6069.2 6082.8 5537.4 5620.0 5622.3 5630.5 5643.9 6454.7 6481.7 6517.5 6570.8 6577.7 4823.2 4867.9 4890.9 4905.2 4932.8 6820.5 6826.5 6844.4 6873.3 6899.8 4972.7 4988.9 4996.9 5025.3 5027.3 5017.4 5048.1 5054.5 5062.7 5080.4 5575.2 5583.3 5601.6 5642.9 5673.3 6433.2 6452.5 6469.9 6500.2 6587.7 1642.5 1693.4 1706.4 1732.3 1743.8 1211.1 1226.6 1244.4 1250.4 1256.2 5520.8 5533.0 5639.2 5642.9 5668.3 6252.8 6528.5 6536.2 6569.7 6728.7 5657.6 5674.7 5690.9 5694.6 5716.7 3507.7 3521.7 3539.4 3543.9 3546.2 6375.9 6379.7 6407.0 6509.8 6519.7 6751.7 6847.7 6871.5 6872.0 6882.3 6381.3 6408.0 6478.1 6478.2 6495.4 6574.7 6637.2 6647.0 6683.4 6695.5 6490.8 6555.2 6586.1 6589.0 6594.5 6254.0 6343.1 6363.3 6401.4 6488.5 4932.2 4936.0 4950.0 4973.2 4987.8 6629.9 6648.6 6686.9 6690.0 6695.3 6478.0 6498.0 6541.8 6563.9 6565.8 6295.7 6329.4 6370.7 6400.3 6409.3 6019.3 6146.0 6228.2 6236.2 6300.0 6326.0 6391.8 6496.2 6518.7 6532.7 6254.2 6260.4 6295.2 6304.7 6309.9 03:25:24 INFO - PID 9301 | 03:25:24 INFO - PID 9301 | [#5] yui.html Cycles:180 Average:21598.50 Median:18921.03 stddev:28888.06 (152.7%) stddev-sans-first:28927.27 03:25:24 INFO - PID 9301 | Values: 895.8 913.9 914.5 917.4 926.9 17734.1 18573.3 18665.4 18724.7 21052.5 19577.5 20298.1 20302.9 20379.6 20387.1 1031.1 1045.8 1047.0 1049.9 1050.0 965.1 1041.8 1042.0 1043.6 1053.2 1077.7 1111.6 1113.3 1115.4 1116.2 1103.5 1104.0 1104.5 1105.7 1115.5 810.4 811.5 812.0 813.0 816.9 18385.4 19117.3 19452.0 19485.8 19546.6 20071.3 20378.1 20467.5 21061.5 21074.8 15513.5 15574.3 15658.6 15672.5 16035.2 3535.4 3544.0 3552.7 3556.8 3565.3 113736.0 119143.0 120361.0 125281.0 127934.4 15955.4 16218.0 16446.3 16998.9 17046.7 29145.9 30442.1 30506.0 30551.0 30714.0 7265.5 7559.7 8127.6 8267.0 8505.4 4069.7 4194.5 4206.5 4207.5 4220.2 4638.4 4761.8 4806.8 4808.3 4868.2 1042.8 1052.9 1055.7 1056.8 1057.0 654.3 676.2 700.0 700.2 707.7 11460.1 11543.2 11640.0 11959.8 12291.0 668.6 701.8 702.8 706.4 719.4 5028.9 5298.3 5361.5 5472.2 5594.2 92830.0 95288.0 95530.5 100657.5 100981.0 86223.6 88244.0 89578.0 91971.0 93746.5 72408.3 74307.0 77120.6 77863.6 78159.2 10957.6 10987.0 11162.0 11317.6 11583.5 32823.5 33555.8 36461.5 37000.3 37538.4 43150.6 44765.6 46459.0 46722.3 47204.3 15425.2 15918.1 15939.1 15973.5 15986.3 15871.3 17081.6 17386.9 17922.4 18033.2 17498.5 17596.5 17789.4 17799.0 17848.8 17398.0 17473.7 17475.7 17518.2 17592.4 17937.9 18075.2 18147.6 18181.8 18241.8 13194.8 13278.5 13619.3 13725.5 13785.9 13393.5 13482.3 13502.0 13521.3 13665.8 03:25:24 INFO - PID 9301 | -------- Summary: end -------- 03:25:24 INFO - PID 9301 | 03:25:25 INFO - TEST-INFO | 9301: exit 0 03:25:25 INFO - TEST-OK | dromaeo_css | took 1113580ms 03:25:25 INFO - TEST-START | kraken 03:25:25 INFO - Initialising browser for kraken test... 03:25:25 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52228/getInfo.html -profile /tmp/tmpgyXNCb/profile 03:25:25 INFO - TEST-INFO | started process 9679 (/builds/slave/test/build/application/firefox/firefox http://localhost:52228/getInfo.html) 03:25:31 INFO - TEST-INFO | 9679: exit 0 03:25:31 INFO - Browser initialized. 03:25:31 INFO - Running cycle 1/1 for kraken test... 03:25:31 INFO - TEST-INFO | started process 9912 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgyXNCb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:25:42 INFO - PID 9912 | RSS: Main: 177348608 03:25:42 INFO - PID 9912 | 03:25:45 INFO - PID 9912 | Cycle 1(1): loaded http://localhost:52228/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52228/tests/kraken/driver.html?testName=audio-beat-detection) 03:25:46 INFO - PID 9912 | RSS: Main: 181456896 03:25:46 INFO - PID 9912 | 03:25:49 INFO - PID 9912 | Cycle 1(1): loaded http://localhost:52228/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52228/tests/kraken/driver.html?testName=audio-dft) 03:25:49 INFO - PID 9912 | RSS: Main: 182005760 03:25:49 INFO - PID 9912 | 03:25:52 INFO - PID 9912 | Cycle 1(1): loaded http://localhost:52228/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52228/tests/kraken/driver.html?testName=audio-fft) 03:25:53 INFO - PID 9912 | RSS: Main: 176607232 03:25:53 INFO - PID 9912 | 03:25:55 INFO - PID 9912 | Cycle 1(1): loaded http://localhost:52228/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52228/tests/kraken/driver.html?testName=audio-oscillator) 03:25:56 INFO - PID 9912 | RSS: Main: 177643520 03:25:56 INFO - PID 9912 | 03:25:58 INFO - PID 9912 | Cycle 1(1): loaded http://localhost:52228/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52228/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:25:59 INFO - PID 9912 | RSS: Main: 177459200 03:25:59 INFO - PID 9912 | 03:26:02 INFO - PID 9912 | Cycle 1(1): loaded http://localhost:52228/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52228/tests/kraken/driver.html?testName=imaging-darkroom) 03:26:02 INFO - PID 9912 | RSS: Main: 180039680 03:26:02 INFO - PID 9912 | 03:26:06 INFO - PID 9912 | Cycle 1(1): loaded http://localhost:52228/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52228/tests/kraken/driver.html?testName=imaging-desaturate) 03:26:07 INFO - PID 9912 | RSS: Main: 179687424 03:26:07 INFO - PID 9912 | 03:26:09 INFO - PID 9912 | Cycle 1(1): loaded http://localhost:52228/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52228/tests/kraken/driver.html?testName=json-parse-financial) 03:26:10 INFO - PID 9912 | RSS: Main: 180334592 03:26:10 INFO - PID 9912 | 03:26:12 INFO - PID 9912 | Cycle 1(1): loaded http://localhost:52228/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52228/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:26:12 INFO - PID 9912 | RSS: Main: 180125696 03:26:12 INFO - PID 9912 | 03:26:14 INFO - PID 9912 | Cycle 1(1): loaded http://localhost:52228/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52228/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:26:15 INFO - PID 9912 | RSS: Main: 180236288 03:26:15 INFO - PID 9912 | 03:26:17 INFO - PID 9912 | Cycle 1(1): loaded http://localhost:52228/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52228/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:26:18 INFO - PID 9912 | RSS: Main: 180043776 03:26:18 INFO - PID 9912 | 03:26:20 INFO - PID 9912 | Cycle 1(1): loaded http://localhost:52228/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52228/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:26:21 INFO - PID 9912 | RSS: Main: 180871168 03:26:21 INFO - PID 9912 | 03:26:24 INFO - PID 9912 | Cycle 1(1): loaded http://localhost:52228/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52228/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:26:25 INFO - PID 9912 | RSS: Main: 180658176 03:26:25 INFO - PID 9912 | 03:26:27 INFO - PID 9912 | Cycle 1(1): loaded http://localhost:52228/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52228/tests/kraken/driver.html?testName=ai-astar) 03:26:27 INFO - PID 9912 | RSS: Main: 182390784 03:26:27 INFO - PID 9912 | 03:26:27 INFO - PID 9912 | __start_tp_report 03:26:27 INFO - PID 9912 | _x_x_mozilla_page_load 03:26:27 INFO - PID 9912 | _x_x_mozilla_page_load_details 03:26:27 INFO - PID 9912 | |i|pagename|runs| 03:26:27 INFO - PID 9912 | |0;ai-astar;100;116;100;109;109;110;111;101;111;110 03:26:27 INFO - PID 9912 | |1;audio-beat-detection;148;117;143;177;118;142;164;119;169;121 03:26:27 INFO - PID 9912 | |2;audio-dft;163;162;163;165;165;163;164;173;162;165 03:26:27 INFO - PID 9912 | |3;audio-fft;75;76;76;158;76;75;75;93;97;75 03:26:27 INFO - PID 9912 | |4;audio-oscillator;82;82;140;82;81;81;126;82;82;130 03:26:27 INFO - PID 9912 | |5;imaging-gaussian-blur;117;115;113;115;115;117;115;115;113;114 03:26:27 INFO - PID 9912 | |6;imaging-darkroom;151;150;151;153;152;150;150;150;152;150 03:26:27 INFO - PID 9912 | |7;imaging-desaturate;94;94;93;95;94;94;94;95;94;94 03:26:27 INFO - PID 9912 | |8;json-parse-financial;53;53;53;55;54;54;54;53;54;54 03:26:27 INFO - PID 9912 | |9;json-stringify-tinderbox;55;54;55;55;54;56;59;58;55;55 03:26:27 INFO - PID 9912 | |10;stanford-crypto-aes;78;78;81;79;79;78;85;78;79;78 03:26:27 INFO - PID 9912 | |11;stanford-crypto-ccm;134;133;131;139;129;132;136;140;138;183 03:26:27 INFO - PID 9912 | |12;stanford-crypto-pbkdf2;186;179;179;184;194;187;182;182;183;180 03:26:27 INFO - PID 9912 | |13;stanford-crypto-sha256-iterative;70;70;72;69;69;74;70;73;74;71 03:26:27 INFO - PID 9912 | __end_tp_report 03:26:27 INFO - PID 9912 | __start_cc_report 03:26:27 INFO - PID 9912 | _x_x_mozilla_cycle_collect,998 03:26:27 INFO - PID 9912 | __end_cc_report 03:26:27 INFO - PID 9912 | __startTimestamp1500805587471__endTimestamp 03:26:27 INFO - PID 9912 | 03:26:27 INFO - PID 9912 | ------- Summary: start ------- 03:26:27 INFO - PID 9912 | Number of tests: 14 03:26:27 INFO - PID 9912 | 03:26:27 INFO - PID 9912 | [#0] ai-astar Cycles:10 Average:107.70 Median:110.00 stddev:5.46 (5.0%) stddev-sans-first:5.03 03:26:27 INFO - PID 9912 | Values: 100.0 116.0 100.0 109.0 109.0 110.0 111.0 101.0 111.0 110.0 03:26:27 INFO - PID 9912 | 03:26:27 INFO - PID 9912 | [#1] audio-beat-detection Cycles:10 Average:141.80 Median:145.50 stddev:22.72 (15.6%) stddev-sans-first:23.99 03:26:27 INFO - PID 9912 | Values: 148.0 117.0 143.0 177.0 118.0 142.0 164.0 119.0 169.0 121.0 03:26:27 INFO - PID 9912 | 03:26:27 INFO - PID 9912 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.50 stddev:3.21 (1.9%) stddev-sans-first:3.35 03:26:27 INFO - PID 9912 | Values: 163.0 162.0 163.0 165.0 165.0 163.0 164.0 173.0 162.0 165.0 03:26:27 INFO - PID 9912 | 03:26:27 INFO - PID 9912 | [#3] audio-fft Cycles:10 Average:87.60 Median:76.00 stddev:26.06 (34.3%) stddev-sans-first:27.24 03:26:27 INFO - PID 9912 | Values: 75.0 76.0 76.0 158.0 76.0 75.0 75.0 93.0 97.0 75.0 03:26:27 INFO - PID 9912 | 03:26:27 INFO - PID 9912 | [#4] audio-oscillator Cycles:10 Average:96.80 Median:82.00 stddev:24.53 (29.9%) stddev-sans-first:25.43 03:26:27 INFO - PID 9912 | Values: 82.0 82.0 140.0 82.0 81.0 81.0 126.0 82.0 82.0 130.0 03:26:27 INFO - PID 9912 | 03:26:27 INFO - PID 9912 | [#5] imaging-gaussian-blur Cycles:10 Average:114.90 Median:115.00 stddev:1.37 (1.2%) stddev-sans-first:1.22 03:26:27 INFO - PID 9912 | Values: 117.0 115.0 113.0 115.0 115.0 117.0 115.0 115.0 113.0 114.0 03:26:27 INFO - PID 9912 | 03:26:27 INFO - PID 9912 | [#6] imaging-darkroom Cycles:10 Average:150.90 Median:151.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 03:26:27 INFO - PID 9912 | Values: 151.0 150.0 151.0 153.0 152.0 150.0 150.0 150.0 152.0 150.0 03:26:27 INFO - PID 9912 | 03:26:27 INFO - PID 9912 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 03:26:27 INFO - PID 9912 | Values: 94.0 94.0 93.0 95.0 94.0 94.0 94.0 95.0 94.0 94.0 03:26:27 INFO - PID 9912 | 03:26:27 INFO - PID 9912 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:0.67 (1.2%) stddev-sans-first:0.67 03:26:27 INFO - PID 9912 | Values: 53.0 53.0 53.0 55.0 54.0 54.0 54.0 53.0 54.0 54.0 03:26:27 INFO - PID 9912 | 03:26:27 INFO - PID 9912 | [#9] json-stringify-tinderbox Cycles:10 Average:55.60 Median:55.00 stddev:1.65 (3.0%) stddev-sans-first:1.73 03:26:27 INFO - PID 9912 | Values: 55.0 54.0 55.0 55.0 54.0 56.0 59.0 58.0 55.0 55.0 03:26:27 INFO - PID 9912 | 03:26:27 INFO - PID 9912 | [#10] stanford-crypto-aes Cycles:10 Average:79.30 Median:79.00 stddev:2.21 (2.8%) stddev-sans-first:2.30 03:26:27 INFO - PID 9912 | Values: 78.0 78.0 81.0 79.0 79.0 78.0 85.0 78.0 79.0 78.0 03:26:27 INFO - PID 9912 | 03:26:27 INFO - PID 9912 | [#11] stanford-crypto-ccm Cycles:10 Average:139.50 Median:137.00 stddev:15.70 (11.5%) stddev-sans-first:16.53 03:26:27 INFO - PID 9912 | Values: 134.0 133.0 131.0 139.0 129.0 132.0 136.0 140.0 138.0 183.0 03:26:27 INFO - PID 9912 | 03:26:27 INFO - PID 9912 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.60 Median:183.50 stddev:4.55 (2.5%) stddev-sans-first:4.74 03:26:27 INFO - PID 9912 | Values: 186.0 179.0 179.0 184.0 194.0 187.0 182.0 182.0 183.0 180.0 03:26:27 INFO - PID 9912 | 03:26:27 INFO - PID 9912 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.20 Median:71.50 stddev:1.93 (2.7%) stddev-sans-first:2.00 03:26:27 INFO - PID 9912 | Values: 70.0 70.0 72.0 69.0 69.0 74.0 70.0 73.0 74.0 71.0 03:26:27 INFO - PID 9912 | -------- Summary: end -------- 03:26:27 INFO - PID 9912 | 03:26:27 INFO - PID 9912 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:26:28 INFO - TEST-INFO | 9912: exit 0 03:26:28 INFO - TEST-OK | kraken | took 62759ms 03:26:28 INFO - SUITE-END | took 1176s 03:26:28 INFO - Completed test suite (00:19:36) 03:26:28 INFO - javascript benchmark 03:26:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8344.659591098729, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3123.312871168342, 3159.004913452261, 3165.287810242695, 3165.9366812663748, 3183.5702180205667, 5984.072468767337, 6208.2550093988675, 6213.906791398127, 6215.689215539228, 6226.533010024249, 6040.456358927696, 6131.8773624527485, 6147.81556553303, 6172.166757487737, 6177.289611694645, 5662.094064949609, 5678.233438485813, 5701.657900525961, 5707.77168913243, 5722.7424765885635, 5760.452756988079, 5781.075027995522, 5783.942160578404, 5797.36229014808, 5797.420257974211, 5657.179708942201, 5716.228309178249, 5737.627054241482, 5744.109663002241, 5752.108423194411, 5523.171524271352, 5624.465675760796, 5628.26832511775, 5711.628744131618, 5752.108423194411, 5601.495865372095, 5665.943340566583, 5668.291463567054, 5684.54523638108, 5695.829125126253, 6007.098935159717, 6087.756489740405, 6114.205153330083, 6140.723667434976, 6150.954337762591, 6415.294317625057, 6524.445422139124, 6524.575902566318, 6598.802035938929, 6612.0, 6675.299093595151, 6696.86606267872, 6709.798706038827, 6723.865522689568, 6771.593704377704, 6165.7533698652, 6168.784092556783, 6178.289496707846, 6253.6247825131095, 6264.7807326743805, 6694.899576506356, 6791.898121528181, 6808.761693340808, 6914.619695916773, 6915.377616014583, 6458.773942911976, 6532.281449040602, 6546.312637173029, 6558.737650493927, 6565.277819439858, 6600.933990660128, 6610.4711623071, 6616.636085015371, 6659.167604049494, 6698.5980841149685, 6402.103705481236, 6559.573627714183, 6563.540552161398, 6617.834554136089, 6666.033425153326, 6466.385693359123, 6486.027095935648, 6487.870242595121, 6489.156409666713, 6498.187726534184, 5249.658772179796, 5250.343707036621, 5267.2889159962915, 5333.173358129496, 5341.813036543703, 4484.8430304939175, 4532.7280363178315, 4585.060062687141, 4607.35497030416, 4620.145273124483, 5693.544516438675, 5837.708114594253, 5839.854003649943, 5846.035404158351, 5848.678322692293, 6653.866922661519, 6672.466202703772, 6684.331566843374, 6762.864742705118, 6785.321467853274, 5599.860003499945, 5667.858303542444, 5693.914591281134, 5755.85610359736, 5764.0, 5718.085106382959, 5723.313202415654, 5727.0, 5728.742206600713, 5729.341125770507, 6370.904436433365, 6406.67966601668, 6424.743010279536, 6425.871482570323, 6469.676516174267, 6556.3443655634055, 6693.966530167513, 6733.797986060426, 6744.123263975652, 6770.32296770319, 6406.967965160145, 6407.647579382992, 6423.518236132402, 6512.772052978313, 6531.150950376421, 6322.905156422749, 6401.807945761635, 6403.4877209824035, 6409.647469389229, 6552.6068435894, 6686.364795344434, 6718.630475323904, 6737.393634572912, 6738.427233685192, 6783.966080169567, 6466.0300954855265, 6473.320301368289, 6533.738650454119, 6549.770758023446, 6550.6069635822005, 6344.143540622142, 6457.321981192095, 6546.574472659262, 6546.934530654823, 6551.4103730664465, 6301.527385446018, 6344.555881088279, 6423.29343772194, 6425.614463132227, 6438.6136831790245, 6438.678066096582, 6494.350564943468, 6510.804675859732, 6511.967440162769, 6558.573692709959, 6182.319944805978, 6190.659513726789, 6234.314225435289, 6293.339199383999, 6359.618422894641], "value": 6044.7868276979025, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [833.6582001379436, 864.0970186155467, 889.4752096263203, 1166.836642869999, 1187.0, 39775.40336894945, 42986.0, 43384.56615433845, 43465.565344346585, 43545.78227108868, 43410.34884476735, 43718.56281437185, 43798.34302485465, 43865.34201986965, 43874.78062609683, 7475.700971961115, 7516.910048043031, 7521.962390188069, 7523.285287897641, 7557.659905304261, 7417.443691723115, 7510.324070833624, 7511.887321690179, 7517.699292028312, 7518.248175182465, 7516.210797866227, 7547.28300811422, 7549.35830454412, 7550.811229719274, 7553.433492488058, 7512.0, 7517.0227870376775, 7517.248275172494, 7519.436042296822, 7519.624018799038, 7519.699212031513, 7576.318131368148, 7580.355669768076, 7581.2418758124295, 7582.279683430065, 39621.80189099036, 39788.60211397907, 39841.80079099586, 39877.60122398768, 39939.20121597581, 3612.710983121344, 3657.524521812147, 3662.1393972416463, 3664.6152154023976, 3669.834857431422, 31580.684193158235, 31637.52543711846, 31662.0, 31754.206144846332, 31787.523187152212, 4583.243764778807, 4735.242361222188, 4738.502457242009, 4784.832530861438, 4792.472827988919, 178744.0, 179384.0, 179979.0, 180029.9999999987, 180431.0, 49105.50894491009, 49366.25950610744, 49396.259056114184, 49921.0, 50801.237981430306, 51783.22325165125, 51818.74090629523, 51822.74088629608, 51919.221211681855, 51947.74026129845, 14160.716785664228, 14227.64430889236, 14247.715045699028, 14815.777763333559, 15370.923145384202, 12070.27578345302, 12387.380630968595, 12390.504379824706, 12393.380330983415, 12400.379981000913, 14918.328675209425, 14985.32566034531, 15031.624209394633, 15103.0, 15185.164815935008, 5822.417758224144, 5822.9138556565085, 5872.590578261186, 5882.1470886722045, 6039.0, 963.6868017894212, 978.5987745024506, 997.7655251016006, 1006.2201793609864, 1006.3257617396362, 22519.43701407445, 22902.885485572464, 22988.88505557495, 23029.654555181685, 23341.0, 1076.434871692352, 1083.4474418046852, 1101.5593762495066, 1107.5569772091228, 1116.0959622705634, 12284.324362160167, 12637.620871373874, 16250.9436886602, 16499.83500164983, 16927.0, 227842.0, 228027.0, 228063.0, 228648.0, 230114.0, 60846.69576652088, 60976.390236097955, 61164.69417652972, 61378.0, 61602.69198653978, 1433.8924580656285, 1461.7661174212287, 1479.578320178744, 1490.0687070580886, 1493.8804895608325, 26834.59748103741, 27492.45015099647, 27511.58732618972, 27558.86220568884, 27701.722982769916, 39556.80221598873, 39725.60274397219, 39860.20279594334, 39890.20219595534, 39924.40113398359, 208832.0, 210452.0, 210575.0, 210786.0, 210892.0, 34593.135171619906, 35272.294554109285, 35516.11209719778, 35620.82189589035, 35835.0, 43537.78231108824, 44872.32691509565, 45041.54958450374, 45152.548474514835, 45535.77232113818, 30333.241668958453, 32333.676663233065, 32584.83707581447, 32823.835880821396, 32859.50710739389, 31931.521027184146, 32086.518702219953, 32132.0, 32522.67477325291, 32788.0, 35052.12369690676, 35271.294574108884, 35443.11392215112, 35748.28503429969, 35900.8204958984, 26304.868475658266, 28780.0, 28942.421151577273, 29155.979540715973, 29228.0, 21234.256801011892, 23690.28929132129, 23695.0, 23784.524309513366, 23911.52176956486], "value": 17432.88864929822, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.3384074473612, 598.3119412675422, 600.2796644027163, 603.6921170203195, 618.9783357582486, 21959.780402195975, 22213.444663883412, 23217.883910580465, 23299.417514562123, 23342.949567269494, 25714.871425642847, 26410.0, 26437.07470238542, 26506.602400964002, 26645.600315995274, 6476.514261430388, 6613.041109039186, 6644.169478815148, 6644.833879153011, 6645.800625981228, 5867.618604790675, 6455.7094930728, 6481.416672499474, 6496.0, 6499.220093588776, 6465.385788350122, 6468.385503377195, 6469.4500967417825, 6470.482361411099, 6474.028895665664, 6462.547621666486, 6465.709043093072, 6466.191726034246, 6470.611763294218, 6471.902921456159, 6024.728887200043, 6033.064874944391, 6035.943709850759, 6040.728167232485, 6045.153678485016, 29024.854875725698, 30031.69968300311, 30075.097747067623, 30278.394432111454, 30590.84704576485, 1891.6595012897674, 1924.4130540185238, 1938.932137375185, 1939.21461807968, 1939.8351140153104, 18781.90609046946, 18798.0, 19089.23643054276, 19241.326553570558, 19289.131989060526, 2272.397814579138, 2286.8513546619415, 2295.116380193621, 2295.8622482650926, 2307.757685443038, 135710.0, 137758.0, 137827.0, 138403.30798346046, 138928.0, 14225.0, 14797.0, 14862.13584468046, 14964.551063468114, 15488.457903973533, 23724.169654062025, 23836.16573419922, 23842.761572384403, 23854.761452385254, 23859.522809543712, 9924.801503970024, 9992.80014399708, 10029.147522460527, 10160.949195253976, 10205.846912296322, 8327.833443331221, 9232.907670923205, 9313.580888860017, 9362.391444556082, 9439.858402123973, 8124.675012999532, 8948.68679596211, 9060.184583387527, 9063.81872362549, 9500.95249523748, 2571.344307201689, 2629.9236183914854, 2649.1125472966773, 2689.5831146172372, 2715.2804506805714, 917.1653795046476, 918.3296193778579, 933.3093510801957, 941.110650435332, 949.4635530925005, 18820.435386938414, 19172.137253823334, 19490.0, 19699.704504432444, 19806.504837378892, 977.9951100244454, 1007.924405669563, 1012.3015119567475, 1037.1702637889657, 1049.842523621463, 10551.84172237417, 10703.197260205516, 10871.510782014828, 10903.29128606638, 11019.669409917715, 451816.70458238805, 463413.0, 465896.0, 471027.0, 473693.0, 112780.0, 114888.0, 115234.42382788032, 116693.0, 117837.0, 1274.6749578857332, 1285.2930888011556, 1292.101989117573, 1293.6054503376372, 1297.007789041384, 16409.91795041017, 17545.56136096608, 17713.468595942144, 17724.734128987817, 17766.555836104202, 52368.73815630897, 52806.471935280155, 53417.198742019675, 54966.72516637551, 55138.0, 70449.29550704427, 70848.0, 70871.0, 71100.0, 71570.28429715845, 14592.197429141499, 14668.119912805267, 14806.185659788815, 14820.0, 14872.479463219168, 22664.320070397913, 22720.318390448312, 22948.541029179658, 23130.53738925246, 23226.187083451998, 17840.3755868544, 18059.0, 18119.184636691643, 18181.909085454914, 18192.181351838935, 13791.724165516835, 14372.86103269974, 14944.0, 15447.691046178788, 15800.130992795506, 18344.816551834843, 18382.908085459487, 18665.066746662884, 18699.34552290663, 18752.906235468734, 13925.930370348084, 13981.790273146114, 14111.364988575744, 14141.0, 14235.074720143157, 17575.82424175793, 18115.54711132232, 18202.817971820114, 18209.362672306404, 18235.0], "value": 11813.790198567978, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1332.0475859760272, 1401.8598140185977, 1402.649337665583, 1405.6345350208942, 1419.7941298511723, 13476.932615336922, 13944.0, 14068.64828379291, 14070.929645351758, 14138.929305353471, 13658.317084145803, 14270.072445291049, 14704.779428308584, 14714.337854796533, 14765.557033288991, 2541.288439237012, 2611.621314909337, 2622.344413896526, 2623.2261482862505, 2626.4484458263787, 2550.4261541153187, 2610.0864697355964, 2676.8661566921674, 2680.557707978181, 2693.4343787804582, 2670.0, 2702.540568103417, 2710.254679963016, 2716.3209197700576, 2721.8366897986084, 2528.2920782180927, 2561.4108754986364, 2617.947641047178, 2675.1573254424793, 2679.69183543893, 2435.805135589166, 2458.40998160442, 2467.0625162438337, 2561.474897645978, 2615.5161295160456, 13760.793588096187, 13892.16647001183, 13929.233892135928, 13933.0, 13948.442062317496, 7212.8557428851655, 7452.701891924316, 7460.888086678704, 7484.027076480077, 7494.850102997964, 4883.560479556857, 5085.338905942203, 5205.557527610158, 5245.291885595434, 5250.789968401259, 1788.919498622565, 1814.2742902838838, 1820.2718912435, 1848.1036697201846, 1880.1633273193434, 21656.35030949074, 21970.670439943413, 22000.0, 22026.669599956014, 22073.779262207332, 6418.614883106935, 6506.772262970773, 6510.967445162744, 6614.470842332602, 6739.326067393222, 14982.40070397172, 15065.397384104514, 15099.698006039818, 15109.773353399707, 15119.244037798066, 7224.67488962998, 7315.195328513859, 7331.706731730777, 7362.263773622702, 7364.77905662831, 6689.09697190873, 6704.396604305538, 6800.455963522906, 6844.1444819397575, 6903.585784852925, 4889.364382630235, 4944.1100601891285, 4951.059298733229, 4990.850274491771, 5021.372328458942, 1174.3130268792681, 1197.3055627735891, 1364.461037890028, 1377.5454100146928, 1442.163545143814, 825.7110011495928, 832.4713806732768, 855.683397143061, 863.8617821148586, 883.7348795361495, 7020.7542736004, 7116.181639111465, 7122.465815063891, 7148.821279467951, 7173.5337203081635, 954.5847556313026, 962.3985009369144, 972.8589354543693, 989.0, 1008.996048931318, 4296.871093867189, 4631.91150079731, 4798.328234047236, 4853.514648535118, 4984.277279794482, 18495.44513664592, 18771.812281877006, 19070.904645476683, 19081.90459047696, 19097.0, 17938.55153621144, 18526.16632251552, 18737.531561711065, 18798.436046918614, 18853.434396968114, 9951.800963980824, 10425.635102771366, 10461.895381046397, 10466.895331046744, 10491.580336786596, 7348.1182258129365, 7628.80927976805, 7825.647845847065, 7900.881486777818, 7928.7621371358955, 15877.444289449813, 16197.51407457778, 16440.260188291315, 16594.0, 16777.748333774758, 16251.756223656892, 16640.084795336374, 16807.41174058902, 16820.663586728442, 16922.915385422995, 10914.890851091704, 11076.5569377224, 11077.667669969915, 11090.390028548507, 11133.053690436403, 12509.937450312691, 12569.120161588968, 12583.811242831182, 12681.0, 12762.0, 9358.578863951274, 9570.090841370058, 9743.512824358895, 10127.341722787995, 10484.842727359248, 9620.0, 10130.797384052425, 10154.796904062025, 10221.182305415698, 10458.163346932379, 9297.395669281475, 9346.20557252641, 9353.719388418358, 9359.953200233955, 9413.717588472357, 6751.257361690308, 6751.392374686302, 7103.857922841617, 7210.351068403659, 7234.240404757425, 7160.57036577807, 7181.533200341961, 7265.782026539212, 7304.561726296439, 7364.852702946018], "value": 6197.264929315949, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [483.4536973220262, 488.6554978739991, 512.7026324731656, 518.911784996551, 519.7609099814085, 5991.880162396749, 6220.44016038557, 6232.563720539564, 6256.6871656417225, 6295.1816263885685, 6003.639781613096, 6026.69866506674, 6087.878242435148, 6088.604240724361, 6144.969275153618, 4871.0, 4897.265410188465, 4940.950590494094, 4942.505749425065, 4960.875978100558, 4697.741624210667, 4911.386076740408, 4950.6287028472825, 4952.479989601094, 4994.97502512487, 4859.757012149378, 4860.829870954517, 4880.341153944225, 4910.386201724785, 4935.5804756595735, 4833.0, 4836.274558816171, 4857.514248575149, 4919.720872573139, 4936.925946110811, 4355.760433176174, 4402.2296098183015, 4449.3548435477, 4467.1735728889935, 4475.172093162775, 5994.310654274727, 6009.1587177795145, 6034.607750496204, 6069.241344831896, 6082.787102451437, 5537.418571050062, 5619.971900140514, 5622.32532096151, 5630.521405680522, 5643.915341269884, 6454.709538070798, 6481.675916204218, 6517.523341130388, 6570.8028759137305, 6577.736890524373, 4823.155947709137, 4867.9269810952865, 4890.877728056791, 4905.23968784839, 4932.778024988848, 6820.522563420563, 6826.4538836892925, 6844.384005439534, 6873.347032031949, 6899.793006209771, 4972.726500042532, 4988.90022199554, 4996.925046124311, 5025.321581586512, 5027.296178535008, 5017.37282839645, 5048.066107770074, 5054.49455054499, 5062.7468626568525, 5080.415752188472, 5575.247341608912, 5583.274174357389, 5601.607887447921, 5642.915356269659, 5673.3475650299915, 6433.228012638419, 6452.451541619015, 6469.935300646934, 6500.219973603198, 6587.670616469158, 1642.5318784146461, 1693.4242357598475, 1706.3686436018504, 1732.3070771691173, 1743.8256174382714, 1211.1098342718094, 1226.6381417481864, 1244.4151248912997, 1250.3623152192447, 1256.1646505074207, 5520.806771762969, 5533.0, 5639.152228124771, 5642.858928526737, 5668.291463567054, 6252.781152659635, 6528.54300198991, 6536.24833144185, 6569.67151642416, 6728.6635668216395, 5657.6322539035655, 5674.687237699378, 5690.886182276331, 5694.629849059798, 5716.685582293014, 3507.6846182681493, 3521.7006554442646, 3539.433690609542, 3543.8759643412873, 3546.2375589248436, 6375.872482550323, 6379.681015949277, 6407.0, 6509.772157974448, 6519.674016299166, 6751.729930802811, 6847.726090956306, 6871.5189936703955, 6872.0, 6882.311768823078, 6381.329960354096, 6407.9814858320415, 6478.125453063776, 6478.157839480931, 6495.388274325188, 6574.704138313883, 6637.203535575762, 6647.036179753812, 6683.43190828785, 6695.4978376620975, 6490.772822951174, 6555.2133743949125, 6586.090033890118, 6588.978708300221, 6594.472442204708, 6253.999360102362, 6343.143675603919, 6363.268224154282, 6401.391867772554, 6488.513361497812, 4932.161532539405, 4936.0, 4949.950500494949, 4973.204287314013, 4987.775550100182, 6629.933700662931, 6648.5678430901835, 6686.866262674622, 6690.026442199465, 6695.263521012587, 6477.967610161919, 6498.0, 6541.757066157415, 6563.901541476977, 6565.80302590923, 6295.748170073146, 6329.417405897815, 6370.6814659267775, 6400.263969643551, 6409.262934762375, 6019.277686677627, 6145.9692701536205, 6228.190335256388, 6236.18929539157, 6300.0, 6325.96837015812, 6391.794830783372, 6496.220453545605, 6518.706658200297, 6532.738690452328, 6254.186955695731, 6260.373962603703, 6295.244570651551, 6304.71628776697, 6309.873802524015], "value": 4993.642731303336, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [895.7715782475468, 913.9131782480662, 914.5015966298366, 917.3945196170529, 926.8517037274036, 17734.113294335297, 18573.257069717194, 18665.4400367989, 18724.719129213056, 21052.473688157803, 19577.51056223595, 20298.086586103625, 20302.89848550759, 20379.592408151828, 20387.08258128384, 1031.128696251668, 1045.796069766396, 1046.9895301046968, 1049.942253176075, 1050.0129877914735, 965.1217392173124, 1041.828098363769, 1041.953112109957, 1043.5929987304958, 1053.1995683280722, 1077.7359546911018, 1111.6276047524088, 1113.3041848844473, 1115.3865374044244, 1116.2019156303243, 1103.4979084516526, 1104.0229396983648, 1104.536094840169, 1105.723569107723, 1115.4534278203662, 810.4124509730457, 811.4887620798859, 812.001238476677, 812.9512229266263, 816.8652172391548, 18385.356512522132, 19117.330893418803, 19452.0, 19485.805141948542, 19546.609067818565, 20071.297504587415, 20378.082986265654, 20467.48831279215, 21061.47346316339, 21074.78925210759, 15513.534593962198, 15574.299156537983, 15658.608534786608, 15672.529824105295, 16035.198240088066, 3535.381308271042, 3543.982280088609, 3552.6980206682465, 3556.78659280444, 3565.286942611462, 113736.0, 119143.0, 120361.0, 125281.0, 127934.36032819869, 15955.361785528681, 16218.0, 16446.259918303705, 16998.915005424893, 17046.659066818593, 29145.854270728512, 30442.086737397913, 30506.0, 30551.0, 30714.0, 7265.491415600963, 7559.697612095564, 8127.59362031896, 8266.958665206635, 8505.404621676547, 4069.7151199415757, 4194.475690538683, 4206.537280899099, 4207.495100587949, 4220.198162349206, 4638.443386793539, 4761.761911904391, 4806.807727690853, 4808.2787581863, 4868.2210846264425, 1042.8175069362983, 1052.9210309226685, 1055.7307886488895, 1056.7569459024314, 1056.99471502642, 654.2933631677777, 676.1953275602018, 700.0304578159286, 700.2087640965676, 707.734599525178, 11460.09253615003, 11543.249688770204, 11640.01059909917, 11959.820602690967, 12291.0, 668.6355936014884, 701.8455939693259, 702.7926761605339, 706.3713295167305, 719.4388377065897, 5028.924566131511, 5298.311219541435, 5361.544268737123, 5472.20653005312, 5594.1888426177975, 92830.0, 95288.0, 95530.52234738921, 100657.49671251743, 100981.0, 86223.56888215519, 88244.0, 89578.0, 91971.0, 93746.53126734459, 72408.27591724016, 74307.0, 77120.61439692878, 77863.61068194623, 78159.21840781633, 10957.56169753201, 10987.0, 11162.0, 11317.603883864025, 11583.536658533565, 32823.507647385784, 33555.83222083874, 36461.45307820438, 37000.25999480049, 37538.436923446716, 43150.568494314655, 44765.552344477444, 46459.0, 46722.29916551187, 47204.291935620306, 15425.228738563252, 15918.124503152438, 15939.123348215959, 15973.520794376187, 15986.280617372013, 15871.28579213915, 17081.572960676083, 17386.913065434594, 17922.372716954844, 18033.1885065175, 17498.475045748648, 17596.472105836845, 17789.37737179244, 17799.0, 17848.821511784718, 17398.0, 17473.650526989644, 17475.737863931798, 17518.211680474666, 17592.38426655061, 17937.910310448366, 18075.186616602547, 18147.637047259246, 18181.818181818013, 18241.817581824544, 13194.80207796903, 13278.468861245441, 13619.250941197934, 13725.519606813714, 13785.931070344584, 13393.464261429433, 13482.258475783927, 13502.0, 13521.323933803467, 13665.79501307501], "value": 8763.28159727482, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1541.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 116.0, 100.0, 109.0, 109.0, 110.0, 111.0, 101.0, 111.0, 110.0], "value": 107.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 117.0, 143.0, 177.0, 118.0, 142.0, 164.0, 119.0, 169.0, 121.0], "value": 141.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 165.0, 165.0, 163.0, 164.0, 173.0, 162.0, 165.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 158.0, 76.0, 75.0, 75.0, 93.0, 97.0, 75.0], "value": 87.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 140.0, 82.0, 81.0, 81.0, 126.0, 82.0, 82.0, 130.0], "value": 96.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 115.0, 113.0, 115.0, 115.0, 117.0, 115.0, 115.0, 113.0, 114.0], "value": 114.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 151.0, 153.0, 152.0, 150.0, 150.0, 150.0, 152.0, 150.0], "value": 150.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 55.0, 54.0, 54.0, 54.0, 53.0, 54.0, 54.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 55.0, 55.0, 54.0, 56.0, 59.0, 58.0, 55.0, 55.0], "value": 55.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 81.0, 79.0, 79.0, 78.0, 85.0, 78.0, 79.0, 78.0], "value": 79.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 133.0, 131.0, 139.0, 129.0, 132.0, 136.0, 140.0, 138.0, 183.0], "value": 139.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 179.0, 179.0, 184.0, 194.0, 187.0, 182.0, 182.0, 183.0, 180.0], "value": 183.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 72.0, 69.0, 69.0, 74.0, 70.0, 73.0, 74.0, 71.0], "value": 71.2, "unit": "score"}]}]} 03:26:28 INFO - Return code: 0 03:26:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:26:28 INFO - # TBPL SUCCESS # 03:26:28 INFO - Running post-action listener: _package_coverage_data 03:26:28 INFO - Running post-action listener: _resource_record_post_action 03:26:28 INFO - [mozharness: 2017-07-23 10:26:28.757945Z] Finished run-tests step (success) 03:26:28 INFO - Running post-run listener: _resource_record_post_run 03:26:28 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 12288; Write bytes: 444067840; Read time: 452; Write time: 418564 03:26:28 INFO - TinderboxPrint: CPU usage
13.2% 03:26:28 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 452 03:26:28 INFO - TinderboxPrint: I/O write bytes / time
444,067,840 / 418,564 03:26:28 INFO - TinderboxPrint: CPU idle
8,272.6 (86.8%) 03:26:28 INFO - TinderboxPrint: CPU user
1,204.5 (12.6%) 03:26:28 INFO - TinderboxPrint: Swap in / out
0 / 0 03:26:28 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 111685632; Read time: 188; Write time: 125552 03:26:28 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:26:28 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 332382208; Read time: 252; Write time: 293012 03:26:29 INFO - Running post-run listener: _upload_blobber_files 03:26:29 INFO - Blob upload gear active. 03:26:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:26:29 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:26:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:26:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:26:29 INFO - (blobuploader) - INFO - Open directory for files ... 03:26:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:26:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:26:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:26:30 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:26:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:26:30 INFO - (blobuploader) - INFO - Done attempting. 03:26:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:26:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:26:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:26:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:26:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:26:31 INFO - (blobuploader) - INFO - Done attempting. 03:26:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:26:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:26:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:26:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:26:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:26:34 INFO - (blobuploader) - INFO - Done attempting. 03:26:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:26:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:26:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:26:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:26:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:26:35 INFO - (blobuploader) - INFO - Done attempting. 03:26:35 INFO - (blobuploader) - INFO - Iteration through files over. 03:26:35 INFO - Return code: 0 03:26:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:26:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:26:35 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b375d183983d07a30757acafaec50ed9fe6b99dfc8c0632acec90aef9e239b9278cba736686c35286da2a97713811fa1a871e84efe016a19af7307f0ce31546", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8e2c0be625fc3aebdca692b6363b2e6632e662b161dc2caadd019a4ff16f18cd97eb72f8fb1d40338e5bd27208a71190e94b895e2f2a932a8a9a27643c84af5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/49108dbd74779ac06d85df5b01a1294307e33e0573c7bec15b98e054a51455099c1ddb57940d7824236c95b2233d1fd2fe8b2f3a30b9a9de3110eb546964e06c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50177931483d628078f2e83ccfdb2559b18ce2d0aa9b3549fd19e70cd56b6278c238a3a8d85063e799c5f093579026f94c64838b8269bbc89fe800e79adc6cc0"} 03:26:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:26:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:26:35 INFO - Contents: 03:26:35 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b375d183983d07a30757acafaec50ed9fe6b99dfc8c0632acec90aef9e239b9278cba736686c35286da2a97713811fa1a871e84efe016a19af7307f0ce31546", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8e2c0be625fc3aebdca692b6363b2e6632e662b161dc2caadd019a4ff16f18cd97eb72f8fb1d40338e5bd27208a71190e94b895e2f2a932a8a9a27643c84af5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/49108dbd74779ac06d85df5b01a1294307e33e0573c7bec15b98e054a51455099c1ddb57940d7824236c95b2233d1fd2fe8b2f3a30b9a9de3110eb546964e06c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50177931483d628078f2e83ccfdb2559b18ce2d0aa9b3549fd19e70cd56b6278c238a3a8d85063e799c5f093579026f94c64838b8269bbc89fe800e79adc6cc0"} 03:26:35 INFO - Running post-run listener: copy_logs_to_upload_dir 03:26:35 INFO - Copying logs to upload dir... 03:26:35 INFO - mkdir: /builds/slave/test/build/upload/logs 03:26:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.688403 ========= master_lag: 0.33 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-07-23 03:26:34.791966) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-23 03:26:34.796914) ========= 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=826874ccc97bd7bf541b4875000001d5-1500800524.142068-1259549072 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/sha512/1b375d183983d07a30757acafaec50ed9fe6b99dfc8c0632acec90aef9e239b9278cba736686c35286da2a97713811fa1a871e84efe016a19af7307f0ce31546", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8e2c0be625fc3aebdca692b6363b2e6632e662b161dc2caadd019a4ff16f18cd97eb72f8fb1d40338e5bd27208a71190e94b895e2f2a932a8a9a27643c84af5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/49108dbd74779ac06d85df5b01a1294307e33e0573c7bec15b98e054a51455099c1ddb57940d7824236c95b2233d1fd2fe8b2f3a30b9a9de3110eb546964e06c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50177931483d628078f2e83ccfdb2559b18ce2d0aa9b3549fd19e70cd56b6278c238a3a8d85063e799c5f093579026f94c64838b8269bbc89fe800e79adc6cc0"} build_url:https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011227 build_url: 'https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b375d183983d07a30757acafaec50ed9fe6b99dfc8c0632acec90aef9e239b9278cba736686c35286da2a97713811fa1a871e84efe016a19af7307f0ce31546", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8e2c0be625fc3aebdca692b6363b2e6632e662b161dc2caadd019a4ff16f18cd97eb72f8fb1d40338e5bd27208a71190e94b895e2f2a932a8a9a27643c84af5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/49108dbd74779ac06d85df5b01a1294307e33e0573c7bec15b98e054a51455099c1ddb57940d7824236c95b2233d1fd2fe8b2f3a30b9a9de3110eb546964e06c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50177931483d628078f2e83ccfdb2559b18ce2d0aa9b3549fd19e70cd56b6278c238a3a8d85063e799c5f093579026f94c64838b8269bbc89fe800e79adc6cc0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-23 03:26:34.824403) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-23 03:26:34.824747) ========= 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=826874ccc97bd7bf541b4875000001d5-1500800524.142068-1259549072 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004458 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-23 03:26:34.909564) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-23 03:26:34.909924) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-23 03:26:34.910287) ========= ========= Total master_lag: 0.53 =========