builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-038 starttime: 1501582710.63 results: success (0) revision: 51ffb9283f0c7c00e08eb8c39b33fbee218c370d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-01 03:18:30.627762) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-01 03:18:30.628125) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-01 03:18:30.628403) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-01 03:18:30.656371) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 03:18:30.656643) ========= 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=8783db0840cc980e80bb0bd400000236-1501580608.527675-1844214705 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-01 03:18:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 109M=0s 2017-08-01 03:18:30 (109 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.139012 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 03:18:30.808296) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 03:18:30.811591) ========= 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=8783db0840cc980e80bb0bd400000236-1501580608.527675-1844214705 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020488 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 03:18:30.860995) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 03:18:30.861281) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 51ffb9283f0c7c00e08eb8c39b33fbee218c370d --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 51ffb9283f0c7c00e08eb8c39b33fbee218c370d --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=8783db0840cc980e80bb0bd400000236-1501580608.527675-1844214705 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-01 03:18:30,985 truncating revision to first 12 chars 2017-08-01 03:18:30,985 Setting DEBUG logging. 2017-08-01 03:18:30,985 attempt 1/10 2017-08-01 03:18:30,985 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/51ffb9283f0c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-01 03:18:31,300 unpacking tar archive at: mozilla-central-51ffb9283f0c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.695271 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 03:18:31.574721) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-01 03:18:31.575029) ========= script_repo_revision: 51ffb9283f0c7c00e08eb8c39b33fbee218c370d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-01 03:18:31.575408) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-01 03:18:31.575691) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-01 03:18:31.585446) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-08-01 03:18:31.585720) ========= /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=8783db0840cc980e80bb0bd400000236-1501580608.527675-1844214705 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:18:31 INFO - MultiFileLogger online at 20170801 03:18:31 in /builds/slave/test 03:18:31 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:18:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:18:31 INFO - {'append_to_log': False, 03:18:31 INFO - 'base_work_dir': '/builds/slave/test', 03:18:31 INFO - 'blob_upload_branch': 'Firefox', 03:18:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:18:31 INFO - 'branch': 'Firefox', 03:18:31 INFO - 'buildbot_json_path': 'buildprops.json', 03:18:31 INFO - 'code_coverage': False, 03:18:31 INFO - 'config_files': ('talos/linux_config.py',), 03:18:31 INFO - 'default_actions': ('clobber', 03:18:31 INFO - 'read-buildbot-config', 03:18:31 INFO - 'download-and-extract', 03:18:31 INFO - 'populate-webroot', 03:18:31 INFO - 'create-virtualenv', 03:18:31 INFO - 'install', 03:18:31 INFO - 'setup-mitmproxy', 03:18:31 INFO - 'run-tests'), 03:18:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:18:31 INFO - 'disable_ccov_upload': False, 03:18:31 INFO - 'download_minidump_stackwalk': True, 03:18:31 INFO - 'download_symbols': 'ondemand', 03:18:31 INFO - 'enable_stylo': False, 03:18:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:18:31 INFO - 'tooltool.py': '/tools/tooltool.py', 03:18:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:18:31 INFO - '/tools/misc-python/virtualenv.py')}, 03:18:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:18:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:18:31 INFO - 'gecko_profile': False, 03:18:31 INFO - 'gecko_profile_interval': 0, 03:18:31 INFO - 'installer_path': 'installer.exe', 03:18:31 INFO - 'log_level': 'info', 03:18:31 INFO - 'log_name': 'talos', 03:18:31 INFO - 'log_to_console': True, 03:18:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:18:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:18:31 INFO - 'opt_config_files': (), 03:18:31 INFO - 'pip_index': False, 03:18:31 INFO - 'suite': 'dromaeojs-e10s', 03:18:31 INFO - 'system_bits': '32', 03:18:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:18:31 INFO - 'title': 'talos-linux64-ix-038', 03:18:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:18:31 INFO - 'use_talos_json': True, 03:18:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:18:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:18:31 INFO - 'work_dir': 'build'} 03:18:31 INFO - [mozharness: 2017-08-01 10:18:31.815068Z] Running clobber step. 03:18:31 INFO - Running pre-action listener: _resource_record_pre_action 03:18:31 INFO - Running main action method: clobber 03:18:31 INFO - rmtree: /builds/slave/test/build 03:18:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:18:32 INFO - Running post-action listener: _resource_record_post_action 03:18:32 INFO - [mozharness: 2017-08-01 10:18:32.843942Z] Finished clobber step (success) 03:18:32 INFO - [mozharness: 2017-08-01 10:18:32.844045Z] Running read-buildbot-config step. 03:18:32 INFO - Running pre-action listener: _resource_record_pre_action 03:18:32 INFO - Running main action method: read_buildbot_config 03:18:32 INFO - Using buildbot properties: 03:18:32 INFO - { 03:18:32 INFO - "project": "", 03:18:32 INFO - "product": "firefox", 03:18:32 INFO - "who": "archaeopteryx@coole-files.de", 03:18:32 INFO - "installer_path": "public/build/target.tar.bz2", 03:18:32 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 03:18:32 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:18:32 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 03:18:32 INFO - "stage_platform": "linux64-stylo", 03:18:32 INFO - "basedir": "/builds/slave/test", 03:18:32 INFO - "buildnumber": 57, 03:18:32 INFO - "platform": "ubuntu64_hw_stylo", 03:18:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:18:32 INFO - "slavebuilddir": "test", 03:18:32 INFO - "taskId": "JdB2V-1jQteAO5rErKrmyQ", 03:18:32 INFO - "branch": "mozilla-central", 03:18:32 INFO - "script_repo_revision": "production", 03:18:32 INFO - "revision": "51ffb9283f0c7c00e08eb8c39b33fbee218c370d", 03:18:32 INFO - "slavename": "talos-linux64-ix-038", 03:18:32 INFO - "repo_path": "mozilla-central" 03:18:32 INFO - } 03:18:32 INFO - Finding installer, test and symbols from parent task. 03:18:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JdB2V-1jQteAO5rErKrmyQ'}, attempt #1 03:18:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JdB2V-1jQteAO5rErKrmyQ'}, attempt #1 03:18:33 INFO - Task dependencies: JhuDbI3YQeS1KwM6F3P5lg 03:18:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg'}, attempt #1 03:18:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.tar.bz2 03:18:34 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.test_packages.json 03:18:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.crashreporter-symbols.zip 03:18:34 INFO - Running post-action listener: _resource_record_post_action 03:18:34 INFO - [mozharness: 2017-08-01 10:18:34.186159Z] Finished read-buildbot-config step (success) 03:18:34 INFO - [mozharness: 2017-08-01 10:18:34.186383Z] Running download-and-extract step. 03:18:34 INFO - Running pre-action listener: _resource_record_pre_action 03:18:34 INFO - Running main action method: download_and_extract 03:18:34 INFO - mkdir: /builds/slave/test/build/tests 03:18:34 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:18:34 INFO - trying https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.test_packages.json 03:18:34 INFO - Downloading https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:18:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:18:34 INFO - Downloaded 989 bytes. 03:18:34 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:18:34 INFO - Using the following test package requirements: 03:18:34 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:18:34 INFO - u'common': [u'target.common.tests.zip'], 03:18:34 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:18:34 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:18:34 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:18:34 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:18:34 INFO - u'mozbase': [u'target.common.tests.zip'], 03:18:34 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:18:34 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:18:34 INFO - u'web-platform': [u'target.common.tests.zip', 03:18:34 INFO - u'target.web-platform.tests.tar.gz'], 03:18:34 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:18:34 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:18:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.common.tests.zip 03:18:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:18:34 INFO - Fetch https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.common.tests.zip into memory 03:18:35 INFO - Content-Length response header: 72390374 03:18:35 INFO - Bytes received: 72390374 03:18:47 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:18:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.common.tests.zip 03:18:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:18:47 INFO - Fetch https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.common.tests.zip into memory 03:18:48 INFO - Content-Length response header: 72390374 03:18:48 INFO - Bytes received: 72390374 03:19:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.talos.tests.zip 03:19:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:19:05 INFO - Fetch https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.talos.tests.zip into memory 03:19:06 INFO - Content-Length response header: 14496467 03:19:06 INFO - Bytes received: 14496467 03:19:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:07 INFO - trying https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.tar.bz2 03:19:07 INFO - Downloading https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:19:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:19:08 INFO - Downloaded 62292244 bytes. 03:19:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.tar.bz2 03:19:08 INFO - mkdir: /builds/slave/test/properties 03:19:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:19:08 INFO - Writing to file /builds/slave/test/properties/build_url 03:19:08 INFO - Contents: 03:19:08 INFO - build_url:https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.tar.bz2 03:19:08 INFO - Running post-action listener: _resource_record_post_action 03:19:08 INFO - Running post-action listener: set_extra_try_arguments 03:19:08 INFO - [mozharness: 2017-08-01 10:19:08.148315Z] Finished download-and-extract step (success) 03:19:08 INFO - [mozharness: 2017-08-01 10:19:08.148413Z] Running populate-webroot step. 03:19:08 INFO - Running pre-action listener: _resource_record_pre_action 03:19:08 INFO - Running main action method: populate_webroot 03:19:08 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:19:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:19:08 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:19:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:19:08 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:19:08 INFO - 'tests': ['damp', 'tps']}, 03:19:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:19:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:19:08 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:19:08 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:19:08 INFO - 'other-e10s': {'tests': ['a11yr', 03:19:08 INFO - 'ts_paint', 03:19:08 INFO - 'tpaint', 03:19:08 INFO - 'sessionrestore', 03:19:08 INFO - 'sessionrestore_many_windows', 03:19:08 INFO - 'sessionrestore_no_auto_restore', 03:19:08 INFO - 'tabpaint']}, 03:19:08 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:19:08 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:19:08 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:19:08 INFO - 'talos_options': ['--mitmproxy', 03:19:08 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:19:08 INFO - '--firstNonBlankPaint'], 03:19:08 INFO - 'tests': ['quantum_pageload_google', 03:19:08 INFO - 'quantum_pageload_youtube', 03:19:08 INFO - 'quantum_pageload_amazon', 03:19:08 INFO - 'quantum_pageload_facebook']}, 03:19:08 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:19:08 INFO - 'talos_options': ['--stylo', 03:19:08 INFO - '--mitmproxy', 03:19:08 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:19:08 INFO - '--firstNonBlankPaint'], 03:19:08 INFO - 'tests': ['quantum_pageload_google', 03:19:08 INFO - 'quantum_pageload_youtube', 03:19:08 INFO - 'quantum_pageload_amazon', 03:19:08 INFO - 'quantum_pageload_facebook']}, 03:19:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:19:08 INFO - 'tsvgr_opacity', 03:19:08 INFO - 'tart', 03:19:08 INFO - 'tscrollx', 03:19:08 INFO - 'cart', 03:19:08 INFO - 'tsvg_static']}, 03:19:08 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:19:08 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:19:08 INFO - 'talos_options': ['--stylo', 03:19:08 INFO - '--stylo-threads=1', 03:19:08 INFO - '--mitmproxy', 03:19:08 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:19:08 INFO - '--firstNonBlankPaint'], 03:19:08 INFO - 'tests': ['tp6_google', 03:19:08 INFO - 'tp6_youtube', 03:19:08 INFO - 'tp6_amazon', 03:19:08 INFO - 'tp6_facebook']}, 03:19:08 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:19:08 INFO - 'talos_options': ['--xperf_path', 03:19:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:19:08 INFO - 'tests': ['tp5n']}}} 03:19:08 INFO - Running post-action listener: _resource_record_post_action 03:19:08 INFO - [mozharness: 2017-08-01 10:19:08.157075Z] Finished populate-webroot step (success) 03:19:08 INFO - [mozharness: 2017-08-01 10:19:08.157167Z] Running create-virtualenv step. 03:19:08 INFO - Running pre-action listener: _resource_record_pre_action 03:19:08 INFO - Running main action method: create_virtualenv 03:19:08 INFO - Creating virtualenv /builds/slave/test/build/venv 03:19:08 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:19:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:19:08 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:19:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:19:08 INFO - Using real prefix '/usr' 03:19:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:19:08 INFO - Installing distribute.............................................................................................................................................................................................done. 03:19:10 INFO - Installing pip.................done. 03:19:10 INFO - Return code: 0 03:19:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:19:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:19:10 INFO - Reading from file tmpfile_stdout 03:19:10 INFO - Output received: 03:19:10 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:19:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:19:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11da1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1549d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1546eb0>, '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 0x1547db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1548240>, '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': '8783db0840cc980e80bb0bd400000236-1501580608.527675-1844214705', '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:19:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:19:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:19:10 INFO - Using env: {'DISPLAY': ':0', 03:19:10 INFO - 'HOME': '/home/cltbld', 03:19:10 INFO - 'LANG': 'en_US.UTF-8', 03:19:10 INFO - 'LANGUAGE': 'en_US:en', 03:19:10 INFO - 'LOGNAME': 'cltbld', 03:19:10 INFO - 'MAIL': '/var/mail/cltbld', 03:19:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:10 INFO - 'MOZ_NO_REMOTE': '1', 03:19:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:10 INFO - 'NO_EM_RESTART': '1', 03:19:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:10 INFO - 'PWD': '/builds/slave/test', 03:19:10 INFO - 'SHELL': '/bin/bash', 03:19:10 INFO - 'SHLVL': '1', 03:19:10 INFO - 'TERM': 'linux', 03:19:10 INFO - 'TMOUT': '86400', 03:19:10 INFO - 'USER': 'cltbld', 03:19:10 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1501580608.527675-1844214705', 03:19:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:10 INFO - '_': '/tools/buildbot/bin/python'} 03:19:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:11 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:19:11 INFO - Cleaning up... 03:19:11 INFO - Return code: 0 03:19:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:19: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:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19: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:19:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11da1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1549d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1546eb0>, '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 0x1547db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1548240>, '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': '8783db0840cc980e80bb0bd400000236-1501580608.527675-1844214705', '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:19:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:19:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:19:11 INFO - Using env: {'DISPLAY': ':0', 03:19:11 INFO - 'HOME': '/home/cltbld', 03:19:11 INFO - 'LANG': 'en_US.UTF-8', 03:19:11 INFO - 'LANGUAGE': 'en_US:en', 03:19:11 INFO - 'LOGNAME': 'cltbld', 03:19:11 INFO - 'MAIL': '/var/mail/cltbld', 03:19:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:11 INFO - 'MOZ_NO_REMOTE': '1', 03:19:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:11 INFO - 'NO_EM_RESTART': '1', 03:19:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:11 INFO - 'PWD': '/builds/slave/test', 03:19:11 INFO - 'SHELL': '/bin/bash', 03:19:11 INFO - 'SHLVL': '1', 03:19:11 INFO - 'TERM': 'linux', 03:19:11 INFO - 'TMOUT': '86400', 03:19:11 INFO - 'USER': 'cltbld', 03:19:11 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1501580608.527675-1844214705', 03:19:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:11 INFO - '_': '/tools/buildbot/bin/python'} 03:19:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:11 INFO - Downloading/unpacking psutil>=3.1.1 03:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:19:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:19:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:19:12 INFO - Installing collected packages: psutil 03:19:12 INFO - Running setup.py install for psutil 03:19:12 INFO - building 'psutil._psutil_linux' extension 03:19:12 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:19:12 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:19:12 INFO - building 'psutil._psutil_posix' extension 03:19:12 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:19:12 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:19:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:19:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:19:13 INFO - Successfully installed psutil 03:19:13 INFO - Cleaning up... 03:19:13 INFO - Return code: 0 03:19:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:19:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11da1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1549d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1546eb0>, '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 0x1547db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1548240>, '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': '8783db0840cc980e80bb0bd400000236-1501580608.527675-1844214705', '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:19:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:19:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:19:13 INFO - Using env: {'DISPLAY': ':0', 03:19:13 INFO - 'HOME': '/home/cltbld', 03:19:13 INFO - 'LANG': 'en_US.UTF-8', 03:19:13 INFO - 'LANGUAGE': 'en_US:en', 03:19:13 INFO - 'LOGNAME': 'cltbld', 03:19:13 INFO - 'MAIL': '/var/mail/cltbld', 03:19:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:13 INFO - 'MOZ_NO_REMOTE': '1', 03:19:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:13 INFO - 'NO_EM_RESTART': '1', 03:19:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:13 INFO - 'PWD': '/builds/slave/test', 03:19:13 INFO - 'SHELL': '/bin/bash', 03:19:13 INFO - 'SHLVL': '1', 03:19:13 INFO - 'TERM': 'linux', 03:19:13 INFO - 'TMOUT': '86400', 03:19:13 INFO - 'USER': 'cltbld', 03:19:13 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1501580608.527675-1844214705', 03:19:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:13 INFO - '_': '/tools/buildbot/bin/python'} 03:19:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:19:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:19:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:19:14 INFO - Installing collected packages: mozsystemmonitor 03:19:14 INFO - Running setup.py install for mozsystemmonitor 03:19:14 INFO - Successfully installed mozsystemmonitor 03:19:14 INFO - Cleaning up... 03:19:14 INFO - Return code: 0 03:19:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:19:14 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:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:14 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:19:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:14 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 0x11da1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1549d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1546eb0>, '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 0x1547db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1548240>, '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': '8783db0840cc980e80bb0bd400000236-1501580608.527675-1844214705', '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:19:14 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:19:14 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:19:14 INFO - Using env: {'DISPLAY': ':0', 03:19:14 INFO - 'HOME': '/home/cltbld', 03:19:14 INFO - 'LANG': 'en_US.UTF-8', 03:19:14 INFO - 'LANGUAGE': 'en_US:en', 03:19:14 INFO - 'LOGNAME': 'cltbld', 03:19:14 INFO - 'MAIL': '/var/mail/cltbld', 03:19:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:14 INFO - 'MOZ_NO_REMOTE': '1', 03:19:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:14 INFO - 'NO_EM_RESTART': '1', 03:19:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:14 INFO - 'PWD': '/builds/slave/test', 03:19:14 INFO - 'SHELL': '/bin/bash', 03:19:14 INFO - 'SHLVL': '1', 03:19:14 INFO - 'TERM': 'linux', 03:19:14 INFO - 'TMOUT': '86400', 03:19:14 INFO - 'USER': 'cltbld', 03:19:14 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1501580608.527675-1844214705', 03:19:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:14 INFO - '_': '/tools/buildbot/bin/python'} 03:19:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:14 INFO - Downloading/unpacking jsonschema==2.5.1 03:19:14 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:19:14 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:19:14 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:19:14 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:19:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:19:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:19:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:16 INFO - Downloading functools32-3.2.3-2.tar.gz 03:19:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:19:16 INFO - warning: no files found matching '*.txt' 03:19:16 INFO - no previously-included directories found matching 'build' 03:19:16 INFO - no previously-included directories found matching 'dist' 03:19:16 INFO - no previously-included directories found matching '.git*' 03:19:16 INFO - Installing collected packages: jsonschema, functools32 03:19:16 INFO - Running setup.py install for functools32 03:19:16 INFO - warning: no files found matching '*.txt' 03:19:16 INFO - no previously-included directories found matching 'build' 03:19:16 INFO - no previously-included directories found matching 'dist' 03:19:16 INFO - no previously-included directories found matching '.git*' 03:19:16 INFO - Successfully installed jsonschema functools32 03:19:16 INFO - Cleaning up... 03:19:16 INFO - Return code: 0 03:19:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:19: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:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19: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:19:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19: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', '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 0x11da1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1549d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1546eb0>, '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 0x1547db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1548240>, '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': '8783db0840cc980e80bb0bd400000236-1501580608.527675-1844214705', '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:19: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:19: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 functools32==3.2.3-2 03:19:16 INFO - Using env: {'DISPLAY': ':0', 03:19:16 INFO - 'HOME': '/home/cltbld', 03:19:16 INFO - 'LANG': 'en_US.UTF-8', 03:19:16 INFO - 'LANGUAGE': 'en_US:en', 03:19:16 INFO - 'LOGNAME': 'cltbld', 03:19:16 INFO - 'MAIL': '/var/mail/cltbld', 03:19:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:16 INFO - 'MOZ_NO_REMOTE': '1', 03:19:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:16 INFO - 'NO_EM_RESTART': '1', 03:19:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:16 INFO - 'PWD': '/builds/slave/test', 03:19:16 INFO - 'SHELL': '/bin/bash', 03:19:16 INFO - 'SHLVL': '1', 03:19:16 INFO - 'TERM': 'linux', 03:19:16 INFO - 'TMOUT': '86400', 03:19:16 INFO - 'USER': 'cltbld', 03:19:16 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1501580608.527675-1844214705', 03:19:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:16 INFO - '_': '/tools/buildbot/bin/python'} 03:19:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:19:16 INFO - Cleaning up... 03:19:16 INFO - Return code: 0 03:19:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:19: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:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19: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:19:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19: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', '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 0x11da1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1549d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1546eb0>, '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 0x1547db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1548240>, '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': '8783db0840cc980e80bb0bd400000236-1501580608.527675-1844214705', '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:19: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:19: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 blobuploader==1.2.4 03:19:16 INFO - Using env: {'DISPLAY': ':0', 03:19:16 INFO - 'HOME': '/home/cltbld', 03:19:16 INFO - 'LANG': 'en_US.UTF-8', 03:19:16 INFO - 'LANGUAGE': 'en_US:en', 03:19:16 INFO - 'LOGNAME': 'cltbld', 03:19:16 INFO - 'MAIL': '/var/mail/cltbld', 03:19:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:16 INFO - 'MOZ_NO_REMOTE': '1', 03:19:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:16 INFO - 'NO_EM_RESTART': '1', 03:19:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:16 INFO - 'PWD': '/builds/slave/test', 03:19:16 INFO - 'SHELL': '/bin/bash', 03:19:16 INFO - 'SHLVL': '1', 03:19:16 INFO - 'TERM': 'linux', 03:19:16 INFO - 'TMOUT': '86400', 03:19:16 INFO - 'USER': 'cltbld', 03:19:16 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1501580608.527675-1844214705', 03:19:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:16 INFO - '_': '/tools/buildbot/bin/python'} 03:19:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:16 INFO - Downloading/unpacking blobuploader==1.2.4 03:19: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:19: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:19: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:19: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:19:17 INFO - Downloading blobuploader-1.2.4.tar.gz 03:19:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:19:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:19:17 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:19:17 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:19:17 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:19:17 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:19:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:19:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:19: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:19: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:19: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:19: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:19:18 INFO - Downloading docopt-0.6.1.tar.gz 03:19:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:19:18 INFO - Installing collected packages: blobuploader, requests, docopt 03:19:18 INFO - Running setup.py install for blobuploader 03:19:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:19:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:19:18 INFO - Running setup.py install for requests 03:19:18 INFO - Running setup.py install for docopt 03:19:18 INFO - Successfully installed blobuploader requests docopt 03:19:18 INFO - Cleaning up... 03:19:18 INFO - Return code: 0 03:19:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:19: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:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19: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:19:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:19 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 0x11da1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1549d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1546eb0>, '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 0x1547db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1548240>, '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': '8783db0840cc980e80bb0bd400000236-1501580608.527675-1844214705', '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:19:19 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:19:19 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:19:19 INFO - Using env: {'DISPLAY': ':0', 03:19:19 INFO - 'HOME': '/home/cltbld', 03:19:19 INFO - 'LANG': 'en_US.UTF-8', 03:19:19 INFO - 'LANGUAGE': 'en_US:en', 03:19:19 INFO - 'LOGNAME': 'cltbld', 03:19:19 INFO - 'MAIL': '/var/mail/cltbld', 03:19:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:19 INFO - 'MOZ_NO_REMOTE': '1', 03:19:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:19 INFO - 'NO_EM_RESTART': '1', 03:19:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:19 INFO - 'PWD': '/builds/slave/test', 03:19:19 INFO - 'SHELL': '/bin/bash', 03:19:19 INFO - 'SHLVL': '1', 03:19:19 INFO - 'TERM': 'linux', 03:19:19 INFO - 'TMOUT': '86400', 03:19:19 INFO - 'USER': 'cltbld', 03:19:19 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1501580608.527675-1844214705', 03:19:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:19 INFO - '_': '/tools/buildbot/bin/python'} 03:19:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:19:19 INFO - Running setup.py (path:/tmp/pip-CEW6qu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:19:19 INFO - Running setup.py (path:/tmp/pip-5GGpSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:19:19 INFO - Running setup.py (path:/tmp/pip-or3yPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:19:19 INFO - Running setup.py (path:/tmp/pip-2zBqzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:19:19 INFO - Running setup.py (path:/tmp/pip-tKb12g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:19:19 INFO - Running setup.py (path:/tmp/pip-tcCRYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:19:19 INFO - Running setup.py (path:/tmp/pip-ZzxC4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:19:19 INFO - Running setup.py (path:/tmp/pip-RxVRLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:19:19 INFO - Running setup.py (path:/tmp/pip-IgSI6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:19:19 INFO - Running setup.py (path:/tmp/pip-p96GWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:19:19 INFO - Running setup.py (path:/tmp/pip-ymEO2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:19:19 INFO - Running setup.py (path:/tmp/pip-ChMR1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:19:20 INFO - Running setup.py (path:/tmp/pip-1QdJhG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:19:20 INFO - Running setup.py (path:/tmp/pip-j9tHRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:19:20 INFO - Running setup.py (path:/tmp/pip-9tZc8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:19:20 INFO - Running setup.py (path:/tmp/pip-j9A6Hr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:19:20 INFO - Running setup.py (path:/tmp/pip-XgsAml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:19:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:19:20 INFO - Running setup.py install for manifestparser 03:19:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:19:20 INFO - Running setup.py install for mozcrash 03:19:20 INFO - Running setup.py install for mozdebug 03:19:20 INFO - Running setup.py install for mozdevice 03:19:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:19:20 INFO - Running setup.py install for mozfile 03:19:20 INFO - Running setup.py install for mozhttpd 03:19:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:19:21 INFO - Running setup.py install for mozinfo 03:19:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:19:21 INFO - Running setup.py install for mozInstall 03:19:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:19:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:19:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:19:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:19:21 INFO - Running setup.py install for mozleak 03:19:21 INFO - Running setup.py install for mozlog 03:19:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:19:21 INFO - Running setup.py install for moznetwork 03:19:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:19:21 INFO - Running setup.py install for mozprocess 03:19:21 INFO - Running setup.py install for mozprofile 03:19:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:19:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:19:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:19:21 INFO - Running setup.py install for mozrunner 03:19:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:19:21 INFO - Running setup.py install for mozscreenshot 03:19:21 INFO - Running setup.py install for moztest 03:19:22 INFO - Running setup.py install for mozversion 03:19:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:19:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:19:22 INFO - Cleaning up... 03:19:22 INFO - Return code: 0 03:19:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:19:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:22 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 0x11da1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1549d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1546eb0>, '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 0x1547db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1548240>, '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': '8783db0840cc980e80bb0bd400000236-1501580608.527675-1844214705', '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:19:22 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:19:22 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:19:22 INFO - Using env: {'DISPLAY': ':0', 03:19:22 INFO - 'HOME': '/home/cltbld', 03:19:22 INFO - 'LANG': 'en_US.UTF-8', 03:19:22 INFO - 'LANGUAGE': 'en_US:en', 03:19:22 INFO - 'LOGNAME': 'cltbld', 03:19:22 INFO - 'MAIL': '/var/mail/cltbld', 03:19:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:22 INFO - 'MOZ_NO_REMOTE': '1', 03:19:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:22 INFO - 'NO_EM_RESTART': '1', 03:19:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:22 INFO - 'PWD': '/builds/slave/test', 03:19:22 INFO - 'SHELL': '/bin/bash', 03:19:22 INFO - 'SHLVL': '1', 03:19:22 INFO - 'TERM': 'linux', 03:19:22 INFO - 'TMOUT': '86400', 03:19:22 INFO - 'USER': 'cltbld', 03:19:22 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1501580608.527675-1844214705', 03:19:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:22 INFO - '_': '/tools/buildbot/bin/python'} 03:19:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:19:22 INFO - Running setup.py (path:/tmp/pip-5tdLUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:19:22 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:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:19:22 INFO - Running setup.py (path:/tmp/pip-EEJ8nK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:19:22 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:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:19:22 INFO - Running setup.py (path:/tmp/pip-KBDC28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:19:22 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:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:19:22 INFO - Running setup.py (path:/tmp/pip-F4vz4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:19:22 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:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:19:22 INFO - Running setup.py (path:/tmp/pip-8bk_1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:19:22 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:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:19:22 INFO - Running setup.py (path:/tmp/pip-JNmsZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:19:22 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:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:19:22 INFO - Running setup.py (path:/tmp/pip-j24vGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:19:22 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:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:19:22 INFO - Running setup.py (path:/tmp/pip-Ebi5R8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:19:22 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:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:19:22 INFO - Running setup.py (path:/tmp/pip-1P7sqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:19:23 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:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:19:23 INFO - Running setup.py (path:/tmp/pip-781mHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:19:23 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:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:19:23 INFO - Running setup.py (path:/tmp/pip-rze7PC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:19:23 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:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:19:23 INFO - Running setup.py (path:/tmp/pip-NsTc8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:19:23 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:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:19:23 INFO - Running setup.py (path:/tmp/pip-myL_ih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:19:23 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:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:19:23 INFO - Running setup.py (path:/tmp/pip-irrHk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:19:23 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:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:19:23 INFO - Running setup.py (path:/tmp/pip-SImLQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:19:23 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:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:19:23 INFO - Running setup.py (path:/tmp/pip-N4xgnY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:19:23 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:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:19:23 INFO - Running setup.py (path:/tmp/pip-aolZjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:19:23 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:19:23 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:19:23 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:19:23 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:19:23 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:19:23 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:19:23 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:19:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:19: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:19: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:19: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:19: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:19:24 INFO - Downloading blessings-1.6.tar.gz 03:19:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:19:24 INFO - Installing collected packages: blessings 03:19:24 INFO - Running setup.py install for blessings 03:19:24 INFO - Successfully installed blessings 03:19:24 INFO - Cleaning up... 03:19:24 INFO - Return code: 0 03:19:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:19:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:19:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:19:25 INFO - Reading from file tmpfile_stdout 03:19:25 INFO - Current package versions: 03:19:25 INFO - argparse == 1.2.1 03:19:25 INFO - blessings == 1.6 03:19:25 INFO - blobuploader == 1.2.4 03:19:25 INFO - docopt == 0.6.1 03:19:25 INFO - functools32 == 3.2.3-2 03:19:25 INFO - jsonschema == 2.5.1 03:19:25 INFO - manifestparser == 1.1 03:19:25 INFO - mozInstall == 1.13 03:19:25 INFO - mozcrash == 1.0 03:19:25 INFO - mozdebug == 0.1 03:19:25 INFO - mozdevice == 0.51 03:19:25 INFO - mozfile == 1.2 03:19:25 INFO - mozhttpd == 0.7 03:19:25 INFO - mozinfo == 0.10 03:19:25 INFO - mozleak == 0.1 03:19:25 INFO - mozlog == 3.5 03:19:25 INFO - moznetwork == 0.27 03:19:25 INFO - mozprocess == 0.25 03:19:25 INFO - mozprofile == 0.28 03:19:25 INFO - mozrunner == 6.13 03:19:25 INFO - mozscreenshot == 0.1 03:19:25 INFO - mozsystemmonitor == 0.3 03:19:25 INFO - moztest == 0.8 03:19:25 INFO - mozversion == 1.4 03:19:25 INFO - psutil == 3.1.1 03:19:25 INFO - requests == 1.2.3 03:19:25 INFO - wsgiref == 0.1.2 03:19:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:19:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:25 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 0x11da1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1549d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1546eb0>, '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 0x1547db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1548240>, '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': '8783db0840cc980e80bb0bd400000236-1501580608.527675-1844214705', '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:19:25 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:19:25 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:19:25 INFO - Using env: {'DISPLAY': ':0', 03:19:25 INFO - 'HOME': '/home/cltbld', 03:19:25 INFO - 'LANG': 'en_US.UTF-8', 03:19:25 INFO - 'LANGUAGE': 'en_US:en', 03:19:25 INFO - 'LOGNAME': 'cltbld', 03:19:25 INFO - 'MAIL': '/var/mail/cltbld', 03:19:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:25 INFO - 'MOZ_NO_REMOTE': '1', 03:19:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:25 INFO - 'NO_EM_RESTART': '1', 03:19:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:25 INFO - 'PWD': '/builds/slave/test', 03:19:25 INFO - 'SHELL': '/bin/bash', 03:19:25 INFO - 'SHLVL': '1', 03:19:25 INFO - 'TERM': 'linux', 03:19:25 INFO - 'TMOUT': '86400', 03:19:25 INFO - 'USER': 'cltbld', 03:19:25 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1501580608.527675-1844214705', 03:19:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:25 INFO - '_': '/tools/buildbot/bin/python'} 03:19:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:25 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:19:25 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:19:25 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:19:25 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:19:25 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:19:25 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:19:25 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:19:25 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:19:25 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:19:25 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:19:25 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:19:25 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:19:25 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:19:25 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:19:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:19:26 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:19:26 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:19:26 INFO - Installing collected packages: simplejson 03:19:26 INFO - Running setup.py install for simplejson 03:19:26 INFO - building 'simplejson._speedups' extension 03:19:26 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:19:27 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:19:27 INFO - Successfully installed simplejson 03:19:27 INFO - Cleaning up... 03:19:27 INFO - Return code: 0 03:19:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:19: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:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19: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:19:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:27 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 0x11da1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1549d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1546eb0>, '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 0x1547db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1548240>, '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': '8783db0840cc980e80bb0bd400000236-1501580608.527675-1844214705', '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:19:27 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:19:27 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:19:27 INFO - Using env: {'DISPLAY': ':0', 03:19:27 INFO - 'HOME': '/home/cltbld', 03:19:27 INFO - 'LANG': 'en_US.UTF-8', 03:19:27 INFO - 'LANGUAGE': 'en_US:en', 03:19:27 INFO - 'LOGNAME': 'cltbld', 03:19:27 INFO - 'MAIL': '/var/mail/cltbld', 03:19:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:27 INFO - 'MOZ_NO_REMOTE': '1', 03:19:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:27 INFO - 'NO_EM_RESTART': '1', 03:19:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:27 INFO - 'PWD': '/builds/slave/test', 03:19:27 INFO - 'SHELL': '/bin/bash', 03:19:27 INFO - 'SHLVL': '1', 03:19:27 INFO - 'TERM': 'linux', 03:19:27 INFO - 'TMOUT': '86400', 03:19:27 INFO - 'USER': 'cltbld', 03:19:27 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1501580608.527675-1844214705', 03:19:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:27 INFO - '_': '/tools/buildbot/bin/python'} 03:19:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:19:27 INFO - Cleaning up... 03:19:27 INFO - Return code: 0 03:19:27 INFO - Running post-action listener: _resource_record_post_action 03:19:27 INFO - Running post-action listener: _start_resource_monitoring 03:19:27 INFO - Starting resource monitoring. 03:19:27 INFO - [mozharness: 2017-08-01 10:19:27.859556Z] Finished create-virtualenv step (success) 03:19:27 INFO - [mozharness: 2017-08-01 10:19:27.860068Z] Running install step. 03:19:27 INFO - Running pre-action listener: _resource_record_pre_action 03:19:27 INFO - Running main action method: install 03:19:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:19:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:19:28 INFO - Reading from file tmpfile_stdout 03:19:28 INFO - Detecting whether we're running mozinstall >=1.0... 03:19:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:19:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:19:28 INFO - Reading from file tmpfile_stdout 03:19:28 INFO - Output received: 03:19:28 INFO - Usage: mozinstall [options] installer 03:19:28 INFO - Options: 03:19:28 INFO - -h, --help show this help message and exit 03:19:28 INFO - -d DEST, --destination=DEST 03:19:28 INFO - Directory to install application into. [default: 03:19:28 INFO - "/builds/slave/test"] 03:19:28 INFO - --app=APP Application being installed. [default: firefox] 03:19:28 INFO - mkdir: /builds/slave/test/build/application 03:19:28 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:19:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:19:46 INFO - Reading from file tmpfile_stdout 03:19:46 INFO - Output received: 03:19:46 INFO - /builds/slave/test/build/application/firefox/firefox 03:19:46 INFO - Running post-action listener: _resource_record_post_action 03:19:46 INFO - [mozharness: 2017-08-01 10:19:46.228672Z] Finished install step (success) 03:19:46 INFO - [mozharness: 2017-08-01 10:19:46.228925Z] Running setup-mitmproxy step. 03:19:46 INFO - Running pre-action listener: _resource_record_pre_action 03:19:46 INFO - Running main action method: setup_mitmproxy 03:19:46 INFO - Skipping: mitmproxy is not required 03:19:46 INFO - Running post-action listener: _resource_record_post_action 03:19:46 INFO - [mozharness: 2017-08-01 10:19:46.230109Z] Finished setup-mitmproxy step (success) 03:19:46 INFO - [mozharness: 2017-08-01 10:19:46.230331Z] Running run-tests step. 03:19:46 INFO - Running pre-action listener: _resource_record_pre_action 03:19:46 INFO - Running pre-action listener: _set_gcov_prefix 03:19:46 INFO - Running main action method: run_tests 03:19:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:19:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:19:46 INFO - Python 2.7.3 03:19:46 INFO - Return code: 0 03:19:46 INFO - grabbing minidump binary from tooltool 03:19:46 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:19:46 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 0x1546eb0>, '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 0x1547db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1548240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:19:46 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:19:46 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:19:46 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:19:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:19:46 INFO - Return code: 0 03:19:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:19:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:19:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:19:46 INFO - ENV: RUST_BACKTRACE is now 1 03:19:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:19:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:19:46 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/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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:19:46 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/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-038 --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:19:46 INFO - Using env: {'DISPLAY': ':0', 03:19:46 INFO - 'HOME': '/home/cltbld', 03:19:46 INFO - 'LANG': 'en_US.UTF-8', 03:19:46 INFO - 'LANGUAGE': 'en_US:en', 03:19:46 INFO - 'LOGNAME': 'cltbld', 03:19:46 INFO - 'MAIL': '/var/mail/cltbld', 03:19:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:19:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:19:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:46 INFO - 'MOZ_NO_REMOTE': '1', 03:19:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:19:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:46 INFO - 'NO_EM_RESTART': '1', 03:19:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:46 INFO - 'PWD': '/builds/slave/test', 03:19:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:19:46 INFO - 'RUST_BACKTRACE': '1', 03:19:46 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:19:46 INFO - 'SHELL': '/bin/bash', 03:19:46 INFO - 'SHLVL': '1', 03:19:46 INFO - 'STYLO_FORCE_ENABLED': '1', 03:19:46 INFO - 'TERM': 'linux', 03:19:46 INFO - 'TMOUT': '86400', 03:19:46 INFO - 'USER': 'cltbld', 03:19:46 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1501580608.527675-1844214705', 03:19:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:46 INFO - '_': '/tools/buildbot/bin/python'} 03:19:46 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/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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:19:46 INFO - mozversion application_buildid: 20170801092414 03:19:46 INFO - mozversion application_changeset: 51ffb9283f0c7c00e08eb8c39b33fbee218c370d 03:19:46 INFO - mozversion application_display_name: Nightly 03:19:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:19:46 INFO - mozversion application_name: Firefox 03:19:46 INFO - mozversion application_remotingname: firefox 03:19:46 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:19:46 INFO - mozversion application_vendor: Mozilla 03:19:46 INFO - mozversion application_version: 56.0a1 03:19:46 INFO - mozversion platform_buildid: 20170801092414 03:19:46 INFO - mozversion platform_changeset: 51ffb9283f0c7c00e08eb8c39b33fbee218c370d 03:19:46 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:19:46 INFO - mozversion platform_version: 56.0a1 03:19:46 INFO - using testdate: 1501582786 03:19:46 INFO - actual date: 1501582786 03:19:46 INFO - starting webserver on 'localhost:35944' 03:19:46 INFO - SUITE-START | Running 2 tests 03:19:46 INFO - TEST-START | dromaeo_css 03:19:46 INFO - Initialising browser for dromaeo_css test... 03:19:46 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35944/getInfo.html -profile /tmp/tmp3vp6Ne/profile 03:19:46 INFO - TEST-INFO | started process 13933 (/builds/slave/test/build/application/firefox/firefox http://localhost:35944/getInfo.html) 03:19:53 INFO - TEST-INFO | 13933: exit 0 03:19:53 INFO - Browser initialized. 03:19:53 INFO - Running cycle 1/1 for dromaeo_css test... 03:19:53 INFO - TEST-INFO | started process 14157 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3vp6Ne/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:19:54 INFO - PID 14157 | 03:19:54 INFO - PID 14157 | (/builds/slave/test/build/application/firefox/firefox:14211): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:19:54 INFO - PID 14157 | 03:20:05 INFO - PID 14157 | RSS: Main: 174108672 03:20:05 INFO - PID 14157 | 03:23:05 INFO - PID 14157 | Cycle 1(1): loaded http://localhost:35944/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35944/tests/dromaeo/cssquery-ext.html) 03:23:06 INFO - PID 14157 | RSS: Main: 175955968 03:23:06 INFO - PID 14157 | 03:26:08 INFO - PID 14157 | Cycle 1(1): loaded http://localhost:35944/tests/dromaeo/cssquery-ext.html (next: http://localhost:35944/tests/dromaeo/cssquery-jquery.html) 03:26:09 INFO - PID 14157 | RSS: Main: 173862912 03:26:09 INFO - PID 14157 | 03:29:10 INFO - PID 14157 | Cycle 1(1): loaded http://localhost:35944/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35944/tests/dromaeo/cssquery-mootools.html) 03:29:11 INFO - PID 14157 | RSS: Main: 174026752 03:29:11 INFO - PID 14157 | 03:32:13 INFO - PID 14157 | Cycle 1(1): loaded http://localhost:35944/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35944/tests/dromaeo/cssquery-prototype.html) 03:32:14 INFO - PID 14157 | RSS: Main: 174432256 03:32:14 INFO - PID 14157 | 03:35:18 INFO - PID 14157 | Cycle 1(1): loaded http://localhost:35944/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35944/tests/dromaeo/cssquery-yui.html) 03:35:18 INFO - PID 14157 | RSS: Main: 175702016 03:35:18 INFO - PID 14157 | 03:38:20 INFO - PID 14157 | Cycle 1(1): loaded http://localhost:35944/tests/dromaeo/cssquery-yui.html (next: http://localhost:35944/tests/dromaeo/cssquery-dojo.html) 03:38:20 INFO - PID 14157 | RSS: Main: 178229248 03:38:20 INFO - PID 14157 | 03:38:20 INFO - PID 14157 | __start_tp_report 03:38:20 INFO - PID 14157 | _x_x_mozilla_page_load 03:38:20 INFO - PID 14157 | _x_x_mozilla_page_load_details 03:38:20 INFO - PID 14157 | |i|pagename|runs| 03:38:20 INFO - PID 14157 | |0;dojo.html;3126.5310203469476;3156.1636166415888;3157.794743341683;3169.445347064264;3170.4610216263245;6113;6184.010558310665;6196.628202307859;6223.875522489548;6292.496600271978;6050.697465126748;6188.690565471731;6189;6199.194104766374;6234.5324100692405;5626.12795016771;5650.689212093323;5669.291338582677;5672.716364181795;5709.200711900337;5699.458551437607;5716.056850619663;5723.055695810186;5726.0552008918685;5735.397783232763;5682;5727.341355744101;5756.079027355624;5779.682117483537;5786.623869448473;5638.943610563882;5707.058335374658;5716.228309178249;5718;5734.598578099555;5403.729813509348;5541.113421852484;5590.944090559083;5610.438956104398;5629.183768353566;5859.118476455345;6095.695215239265;6141.4472697456995;6147.538934579924;6163.845903852395;6552.049952756824;6605.57063790852;6615.569987950767;6667.633280169589;6698.49761267902;6649.468042556584;6684.532082754209;6693.598384096969;6722.529422940396;6763.763268285636;6239.750409983595;6274.466670333027;6275.592086514362;6282.685865706742;6285.057241413824;6838.247792742794;6933.064036355128;6938.479614028968;6945.826354341081;6962.2341542430295;6489.740410383626;6540.9672951635885;6602.86794264112;6609.173853268341;6612.768553100618;6477.4494167996245;6530.379613936669;6569.310222426672;6593.076969224312;6681.298463661343;6563.737450502022;6565;6642.43539299165;6648.900266496006;6652.201735791639;6677.699503522354;6706.631135287606;6715.7985260442265;6732.932670673231;6752.966235168793;5340.813071542478;5340.91988620171;5413.485718856781;5423.29497165366;5426.70153141581;4557.954420455753;4607.3319368691355;4634.490206077328;4641.234196357631;4641.582257596765;5694.259746233046;5762.4525670061275;5766.163906233573;5768.451997060272;5776;6656.5340426169705;6666.866662666719;6750.8649827004165;6751.493637977172;6754.5947243165565;5777.537796976232;5815.680137592389;5823.184754134425;5847.386024467455;5865.589408741433;5816.709164541756;5824.242848429677;5885.146653735184;5909.438603332676;5921.348651648315;6312.2740884796995;6423.582467139621;6453.548251622436;6524.151860258136;6544.509161812883;6635.071090047494;6689.431398331197;6693.029510721016;6694.096296999843;6696.7656132035145;6365.490760739037;6444.452221561032;6457.031445283245;6462.579932304385;6475.061116138228;6472.644004579794;6499.935000650122;6501.707423165874;6508.902366464602;6530.967345163243;6705.061291419108;6748.122744043243;6749.223839258351;6804.4896632753735;6847.520673552804;6439.7424103035355;6447.097406363019;6453.515986300952;6552.770653027121;6553.344665533599;6324.557280990287;6385.457236134795;6419.101325814483;6533.444657204191;6551.246606640298;6410.294867564471;6427.614343139427;6434.8391290218115;6439.388258115471;6451.548391612542;6511.609303441809;6514.54398192141;6570.441512471302;6583.63789991555;6612.537122401386;6280.497560195265;6311.589746666452;6321.5258855586935;6405.327440618668;6426.164598602152 03:38:20 INFO - PID 14157 | |1;ext.html;805.3195050182597;874.9737507874764;902.9503377314245;1126.7408496045914;1155.353002318701;29363.85318073409;39866.2026759465;40187.598124018754;40381.79809100951;40490.797546012225;39300.410493842544;39694.20611587766;39808.60191398085;39844.40233396494;39857.601423985754;7467.626618669058;7554.999999999973;7600;7612.619369031554;7664.846703065935;7092.219855815856;7543.283388078124;7591.924080759177;7603.923960760377;7609.201033891445;7540.773776786705;7564.886526702104;7583.090029196476;7585.317321441069;7598.08822941245;7547.245275472464;7591.734289299903;7597.810054748647;7600.695972161135;7604.771856844248;7498.587577683225;7516.812079698051;7525.096988361377;7538.62306884659;7542.886856697154;36514.63485365139;36766.44850327247;36787.816060919795;36939.63060369389;36967.630323696685;3477.2176260341475;3495.2310491691787;3518.8416521256604;3525.576930768324;3526.0655926179584;29780.40439191204;29826.85086574575;29855.402891942256;29900.401991960258;29931.850340748373;4641.3270075839155;4859.319695242669;4899.828506002308;4908.067467181224;4976.4277108132665;187053;187396.99999999863;187989;188624;189080;45746.31380529295;45771.31343029857;46223;46380.53619463762;46667.29999050017;49229.75385123052;49418.50581494211;49640.0287976961;49656.50343496591;49728.75135624299;14501.854981450262;14570.05294655844;14655.413783448543;14657.34041968114;14666.779998300033;11709.180357374902;11717.648470545897;11735.061195104372;11746.70633234176;11835.822462663067;12914.160579562298;13215.867841321464;14547.636309092146;14866;14880.330385132695;5816.709164541756;5877.4122587740885;5916.940830591639;5963.7912673056235;6073;983.9901600984042;987.8616993620899;988.7824678570703;1018.2973748113777;1020.4744556553381;22703.545929081327;22929.19747808852;23594.410139746302;28121.71878281191;28878.855605721837;1048.66442738323;1078.7087486378634;1090.291310648085;1102.404701461202;1108.3128460354633;11474.254173478697;11527.689057048761;11838.704032399259;11904.583339583072;12100.273983560839;214143;216890;217218;217343;217829;49097.263541046916;49142.50857491451;49196.75401622969;49214;49278.26082608764;1453.5711964970149;1462.144645382442;1484.9925750371178;1487.5686051045075;1503.6316102554724;21178.894105529373;21272.149114035266;21293.89353053225;21463.034163462995;21604;41273.79363103165;43135.35296970485;44779;44858;45121.323180152984;204076;206480;206579;206954;207277;34376.31247374989;34771.65228347785;35061.29877402489;35092;36514;45055.77472112618;45486;45530.54469455263;45580;46076.7696161517;31587.84206078955;32485.51271730973;32616.673833262314;32701.509477357384;32965.34069318648;31237.531437028916;31387.372252555277;32224.516632250066;32493.67506325001;33092;36125.27749445049;36181;36278;36326.45510317294;36632.08419789527;30925.381492370478;31579.210519736273;32199.034028979167;32328.35343293074;32423;24004.87997560001;24058.15796447116;24454;24644.383890402165;25056.24831255065 03:38:20 INFO - PID 14157 | |2;jquery.html;559.9076152434849;569.9629524080935;572.2789285500269;578.8292453726153;600.6246096189882;21635.891820540895;22573.887130564322;22602.66096008559;22612.208572699958;23054.88472557639;22550.548989020208;22960.77039229607;23047.539049219005;23083.307500775005;23093.884530577365;6365.267994180682;6522.1521202243875;6542.182227221598;6547.377999090078;6549.410553050225;6147.354527774586;6352.809415717513;6393.712282947278;6829.692663830139;6832.2826103259185;6819;6829.282925292847;6838.179418469791;6849.04113424121;6851.828704282408;6743.629100399476;6810.5913645181445;6817;6828.760993365233;6833.487488438363;6698.062271282024;6704.731810727565;6712.731490740364;6716.731330746764;6722.7647032354125;30127.849360753276;31583.684163158305;31980.520292195637;32801.83599081989;33104.6689533104;1927.2483731344787;1944.562473443478;1962.1366598696527;1963.7741659709172;1970.1429878003114;20011.699824502644;20319.79680203194;20411.183552657876;20438.182472701075;20464.181432742822;2406.819488538349;2462.9014839406404;2519.0553542421594;2537.619357096432;2541.3265484646586;138881;139362.30318848442;141295.29352353173;141827;142100.28949855288;20051.699224511645;21364.679529807065;21482.61413507557;22804.31587052391;22959.770402296097;42834.57165428368;42925.570744292156;43171;43453.34819977703;43518.56481435208;10885.129189664807;11019.724506887393;11034.724131896606;11072;11373.829392559119;9081.77295567603;9124.133207345292;9137.908620913706;9185;9297.860532092023;9077.455352678728;11066.833997490045;11151.442427878574;11337.943310283561;11801.35092569917;3581.7313701472494;3705.5923848376656;3883.931918722374;3936.2605524751602;4425.778711064434;969.4474149734583;972.9367591106555;980.7401038724744;1000.1698590170287;1001.2540657210279;19031.80968190328;19697;19755.40733777989;19891;20574.27990020372;1017.2370721958531;1019.5564929255797;1038.99480502597;1040.1003132290666;1048.6853943816825;10738.302010369302;12946.935265323613;13631.454741810216;13778.242196679079;13954.441822326993;501744;513964;514986;520266;524263;121447;123382;124256.37871810763;124413.37793310976;126020;1201.8497687789027;1233.9876601233873;1276.5213045108085;1278.7442511497738;1281.3785314122456;20464.590708185457;21344.679829802877;21466.785332147105;21649.675254871505;22127.33617991463;58894.70552647209;59690.40309597022;62024;63756.36243637504;63842.68078659577;71275.28724712686;73579.63210184129;73694.26305736873;73705.63147184445;73987.26012739804;14426.711465770415;15108;15111;15134.924325378302;15213.163276019925;23529.764702352757;23606.527869442172;24560.50878982446;24670.62994055055;24851.25446236616;19088.23647054158;19431.125599348346;19599.902000489907;19639.31262405809;19697.901510492356;15538.533843984698;15604.531864044096;17297.30810767555;17495.72555567768;17746.64506709833;19706.21175152978;19727.309544165884;19903.701444478054;19916.103775330434;19932.70100948516;14153.292335383396;14163.291835408394;14388.20864852443;14400.783988239975;14420;17960.461186164437;17969.550761231072;18107.637847243244;18151.818481815542;18183.54541136429 03:38:20 INFO - PID 14157 | |3;mootools.html;1337.839459264888;1374.814400055992;1419.3754747910918;1420.1550077703762;1422.6698037335093;13232.206067635949;13940.233287169202;13944.581662550114;13948.302584870766;13968.58094257174;13800.44798208073;14159.646008849784;14634.26828658568;14675.926620366883;14683.119012859235;2672.986635066822;2742.081402730078;2744.0121556239837;2744.217897899099;2744.3962328287744;2592.883320250584;2663.9467210655775;2682.208748419221;2726.0458839406247;2754.5454999924987;2696.892124315025;2731.8360898346164;2733.521633714102;2733.740294672003;2735.2067900308884;2593.48130373925;2616.869156542175;2630.3818602628367;2636.037846186138;2663.8401695898115;2610.099515667092;2628.8554129522868;2646.2855029142024;2651.164883061829;2651.7348265173523;13282.867171328357;13655.180689158682;13655.863441365558;13670.726585468334;13673.24797136157;7309.195988441267;7516.323530882247;7563.7352692655495;7576.0908690956885;7583.127940286828;4985.601151907838;5034.0686972910125;5142.151544995108;5156.20078887773;5210.557102646279;1718.8538974187209;1724.6550689861951;1754.7631069805668;1770.9026003569797;1781.5724226185753;23005.76994230053;23635.527289454287;23665.408364790845;23689;23711.762882371127;6888.552244104118;7053.294670533009;7188.568685878864;7279.235680253497;7299.671514781848;15793.21033948298;15901.443449479213;15918.283677234553;15936.442224522318;15939.681206375808;7464.365528929993;7605.277498637621;7637.69449222036;7638.197989211053;7652.120006199247;6920.100386949664;6960.408365288906;7030.613316267654;7043.929560704328;7075.292470752986;5182.53357197854;5293.523582877559;5327.786888524493;5336.546393556514;5384.353877534642;1376.6420730609914;1420.46022511445;1548.1485183149223;1583.1688363608966;1600.2398860541382;817.1215942861447;832.1054866019053;836.8995720513577;867.9956600216958;884.5002573545926;7474.887876681854;7551.131619863676;7593.126790419173;7652.234776522303;7653.885191722128;952.6903756279237;976.7216343342113;976.9658061967797;989.7129832348683;990.7869807991173;4370.344448332776;4658.254679251304;4700.271457924027;4762.64280178988;4797.592204662643;18104.18531166074;18233.7264941026;19002.904985474983;19032.809671903382;19394.903025484782;19081.904590477236;19233.711494327596;19248.711269330972;19313.4205973821;19321.323753668836;10257.435841028815;10492.475376231157;10632.893671063344;10702;10739.946300268604;7501.249875012455;7721.53670779755;7732.806679833049;8042.477238979448;8049;16162.757558636395;16406.17969101564;16883.57791055184;16922.915385422995;17217.31130754756;16549.338026478807;16977;17125.74311385355;17223.31106755716;17360.045197514257;11254.887451125383;11608.12939029593;11614.477348519167;11617.767644647229;11618.825717614074;13047.934760326138;13099.803502947654;13236.272005039815;13289.335533223493;13379.732405352033;10122.949385253027;10489.370637761758;10656.57373705043;10736.73158171052;10813.67558973232;9895;10359.482025898826;10375;10423;10612.363258204532;8638.740837774876;8699.173578510032;8730.083341249077;8749.16882896124;8758.562071896253;6442.8389290268115;6547.70535325902;6570.638614876228;6609.372109649576;6796.626185559644;6171.413715697002;6495.188101487314;6516.380943810331;6647.5014373921185;6696.7656132035145 03:38:20 INFO - PID 14157 | |4;prototype.html;491.75289417067927;498.4105804324792;518.4400847085149;522.8117877564074;523.4399192863638;6140.478059364954;6191.938080619192;6230.595011324261;6264.530160237978;6313.348393674651;5895.145203945436;5978.252718410199;6081.604695694777;6128.479079278256;6165.876682466348;4860.635452341088;4871.829485967992;4904.337914381566;4904.877378065541;4919.877003074916;4914.827981020665;4917.311576379309;4932.901341973158;4952.479989601094;4988.800447982077;4720.575148236658;4815.205491093965;4836.97581512092;4900.264960255954;4911.16510193268;4809.446913604946;4908.165611845995;4918.458969513386;4938.209886418156;4948.554630083309;4393.143337049277;4414.249577571821;4420.447444069491;4431.33529970507;4458.308962110878;6020.909686354665;6042.516598672096;6049.364816694228;6095.573309868311;6148.739508400812;5610.158476228557;5668.914966275509;5674.290713660793;5687.952337158661;5717.285339332583;6438.742450301982;6456.354364563553;6463.7091330890225;6519;6521.380468855451;4787.593054590329;4840.733759643218;4847.151748444008;4870.902581948377;4878.682885612459;6874.69380817643;6887.276835932205;6902.171739391305;6924.425837201051;6940.514164008572;4907.288443175719;4957.860186744109;4960.206366981266;4963.478834722375;4990.126727822617;5056;5056;5061.519155680205;5067.8986420271385;5081.136206844845;5540.279763630702;5594.552435805126;5688.800891968761;5705.885882282331;5707.200991861143;6452.322506136788;6453.838654033593;6472;6475.838104047437;6533.379328963741;1641.8522332990087;1712.7174016287422;1715.62256303613;1743.991280043617;1752.7905745035885;1188.2217147768226;1203.3682316783759;1206.4209179593845;1218.2751262998502;1219.9268043917393;5728.598998070095;5740.799072032459;5777.826665200051;5797.449242321973;5804.4775970162045;6429.678516074177;6569.408753212234;6637.46900247979;6660.167479065117;6750.1562304711915;5686.3744988051285;5691.8292451226525;5722.513586345207;5766.336871259775;5809.157672137517;3519.5072689823446;3565.3404120237838;3567.1438854674693;3576.6780989710533;3645.8177091145335;6461.93058297305;6476.773312934119;6517.706703198368;6518.762804177322;6592.472602191813;6922.307769223037;6935.514513983972;6949.583025018515;6973.803251975612;6993.89509157363;6382.968085159545;6475.32009139043;6491.870162596627;6546.574472659262;6567.408933196035;6715.697793599397;6723.596584204964;6739.157605299338;6770.119884414995;6771.950347696115;6576.8490514158875;6591.604503729792;6658.400743933069;6715.294894036056;6741.966290168518;6497.382748638872;6515.73937042513;6569.671516424064;6581.901271480836;6583.749087673326;4905.460399355997;4908;4919.852404427873;4938.728369939688;4966.726830024239;6618.768343107968;6684.457237664046;6734.676536594867;6751;6760.797176084725;6442.387973142544;6478.740850366121;6518.674066296761;6523.934760652332;6586.78144543261;6418.967905160444;6420.935790642034;6475.838104047437;6486.351364863476;6555.311692272434;6071.787487437919;6198.504119670506;6239.126522286792;6363;6444;6389.52078594098;6421.743130274736;6431.356864313531;6434.774782882764;6495.570974385628;6230.501559875109;6256.374362563707;6279.591826531261;6356.09317204846;6382.181078392636 03:38:20 INFO - PID 14157 | |5;yui.html;814.2590242878978;831.1605278668543;831.3556993330168;883.748131782442;910.7449914024073;16536.58658533537;16928.57678558035;17507.562310942216;17563.82436175638;17594.82405175948;15099.396024159021;18253.543661408472;18579.163937622805;18663.066846657646;18782.624347513043;1008.173297895724;1034.6947650443099;1035;1035.2701345551407;1035.3735989726183;972.0765272990652;1027.5119318323812;1029.6653587584065;1030.0214795943884;1054.920880933933;1104.4091411095067;1107.9889201108006;1110.8000559899215;1111.4276147783899;1111.8776934537195;1099.74705817662;1104.282216559235;1104.3981030338484;1104.5581767293068;1108.0526150141593;803.1406395157184;811.4563242627395;812.0255693168222;812.354178428151;812.4800127918137;15697.68604627901;15737.370505179779;15930.283137258852;15974.840251597452;18944.431667049874;20057.598848023103;20109.39671809848;20850;20867.791322086738;21222.893885530473;15428.305726242346;15601.531954041397;15814.9209253953;15898.52304430869;15900.363985440568;3414.8121853298057;3439.3809114359406;3443.1220038889924;3465.1337165708574;3469.7397695172963;115359;123107;125297;125464;128319;15440.691186176213;16305.347786088661;16367.345306187619;16391.508254752378;16492.34030638785;29774;30557.23606909845;30577.541336879964;30673.539896901566;30765.69234307673;8889.511076890703;9147.679831205876;9227.53862306882;9274.814503709888;9317.767055823522;4294.26997410441;4386.078923426053;4387.539308372575;4393.055493069006;4397.692161548661;4706.929396059062;5256.106461901486;5269.209618557247;5410.323709536308;6049.788257411057;1073.2969904712427;1092.5247517329988;1115.041064684371;1116.944487459343;1122.1359553144196;663.8240866170469;667.8497338098986;678.1658559971263;680.1260380411148;692.8129405060706;11046.889531104747;11500.309981401142;11992.940035299942;12340.50637974489;12494.625161245178;628.7642134199675;645.106527459472;657.5890068707058;662.9569078009914;688.8518968421813;4914.459409464956;4961.925571116436;4975.651704380731;4999.500049995044;5119.795208191705;100175.49912250538;100675.49662251642;102462.48768756108;104234;105919.4704026475;82692;83201;88830;91537.54231228802;92316.53841730882;72545.27454725385;75050;76483;77700.61149694328;78292;9648;9650.131488166098;9951.278015141177;10015.849762253427;10068.295219334575;34008.65991340055;36141;36529.81735091307;36567.26865462623;36675.44986825253;64051.35948640454;64906;66310.33689663041;66618.33381666121;68834.65582672255;18080.186391612147;18366.173522191802;18602.720959185895;18735.437936861916;18916.716249256;16866.325346985985;20498.487537811674;20550.28074017402;20629.381118566467;20795.168193272704;17859.46421607354;18447.53881152982;18530;18579.16393762257;18786.060696964825;16806.495805125865;17013.14934253307;18358.357457488924;18899.055047247857;18959;17306.394276200273;17482.125893705008;17767.822321776617;17843.197056132765;17930;13388.866111338762;13669.589912302647;13684.65788355299;14044;14087.506937257147;13624.612965056196;13679.31603419845;14048.859511404755;14193.07744996572;14558.980871338905 03:38:20 INFO - PID 14157 | __end_tp_report 03:38:20 INFO - PID 14157 | __start_cc_report 03:38:20 INFO - PID 14157 | _x_x_mozilla_cycle_collect,385 03:38:20 INFO - PID 14157 | __end_cc_report 03:38:20 INFO - PID 14157 | __startTimestamp1501583900983__endTimestamp 03:38:20 INFO - PID 14157 | 03:38:21 INFO - PID 14157 | ------- Summary: start ------- 03:38:21 INFO - PID 14157 | Number of tests: 6 03:38:21 INFO - PID 14157 | 03:38:21 INFO - PID 14157 | [#0] dojo.html Cycles:165 Average:6130.11 Median:6405.33 stddev:725.43 (11.3%) stddev-sans-first:688.33 03:38:21 INFO - PID 14157 | Values: 3126.5 3156.2 3157.8 3169.4 3170.5 6113.0 6184.0 6196.6 6223.9 6292.5 6050.7 6188.7 6189.0 6199.2 6234.5 5626.1 5650.7 5669.3 5672.7 5709.2 5699.5 5716.1 5723.1 5726.1 5735.4 5682.0 5727.3 5756.1 5779.7 5786.6 5638.9 5707.1 5716.2 5718.0 5734.6 5403.7 5541.1 5590.9 5610.4 5629.2 5859.1 6095.7 6141.4 6147.5 6163.8 6552.0 6605.6 6615.6 6667.6 6698.5 6649.5 6684.5 6693.6 6722.5 6763.8 6239.8 6274.5 6275.6 6282.7 6285.1 6838.2 6933.1 6938.5 6945.8 6962.2 6489.7 6541.0 6602.9 6609.2 6612.8 6477.4 6530.4 6569.3 6593.1 6681.3 6563.7 6565.0 6642.4 6648.9 6652.2 6677.7 6706.6 6715.8 6732.9 6753.0 5340.8 5340.9 5413.5 5423.3 5426.7 4558.0 4607.3 4634.5 4641.2 4641.6 5694.3 5762.5 5766.2 5768.5 5776.0 6656.5 6666.9 6750.9 6751.5 6754.6 5777.5 5815.7 5823.2 5847.4 5865.6 5816.7 5824.2 5885.1 5909.4 5921.3 6312.3 6423.6 6453.5 6524.2 6544.5 6635.1 6689.4 6693.0 6694.1 6696.8 6365.5 6444.5 6457.0 6462.6 6475.1 6472.6 6499.9 6501.7 6508.9 6531.0 6705.1 6748.1 6749.2 6804.5 6847.5 6439.7 6447.1 6453.5 6552.8 6553.3 6324.6 6385.5 6419.1 6533.4 6551.2 6410.3 6427.6 6434.8 6439.4 6451.5 6511.6 6514.5 6570.4 6583.6 6612.5 6280.5 6311.6 6321.5 6405.3 6426.2 03:38:21 INFO - PID 14157 | 03:38:21 INFO - PID 14157 | [#1] ext.html Cycles:180 Average:37150.84 Median:19305.42 stddev:52817.23 (273.6%) stddev-sans-first:52894.89 03:38:21 INFO - PID 14157 | Values: 805.3 875.0 903.0 1126.7 1155.4 29363.9 39866.2 40187.6 40381.8 40490.8 39300.4 39694.2 39808.6 39844.4 39857.6 7467.6 7555.0 7600.0 7612.6 7664.8 7092.2 7543.3 7591.9 7603.9 7609.2 7540.8 7564.9 7583.1 7585.3 7598.1 7547.2 7591.7 7597.8 7600.7 7604.8 7498.6 7516.8 7525.1 7538.6 7542.9 36514.6 36766.4 36787.8 36939.6 36967.6 3477.2 3495.2 3518.8 3525.6 3526.1 29780.4 29826.9 29855.4 29900.4 29931.9 4641.3 4859.3 4899.8 4908.1 4976.4 187053.0 187397.0 187989.0 188624.0 189080.0 45746.3 45771.3 46223.0 46380.5 46667.3 49229.8 49418.5 49640.0 49656.5 49728.8 14501.9 14570.1 14655.4 14657.3 14666.8 11709.2 11717.6 11735.1 11746.7 11835.8 12914.2 13215.9 14547.6 14866.0 14880.3 5816.7 5877.4 5916.9 5963.8 6073.0 984.0 987.9 988.8 1018.3 1020.5 22703.5 22929.2 23594.4 28121.7 28878.9 1048.7 1078.7 1090.3 1102.4 1108.3 11474.3 11527.7 11838.7 11904.6 12100.3 214143.0 216890.0 217218.0 217343.0 217829.0 49097.3 49142.5 49196.8 49214.0 49278.3 1453.6 1462.1 1485.0 1487.6 1503.6 21178.9 21272.1 21293.9 21463.0 21604.0 41273.8 43135.4 44779.0 44858.0 45121.3 204076.0 206480.0 206579.0 206954.0 207277.0 34376.3 34771.7 35061.3 35092.0 36514.0 45055.8 45486.0 45530.5 45580.0 46076.8 31587.8 32485.5 32616.7 32701.5 32965.3 31237.5 31387.4 32224.5 32493.7 33092.0 36125.3 36181.0 36278.0 36326.5 36632.1 30925.4 31579.2 32199.0 32328.4 32423.0 24004.9 24058.2 24454.0 24644.4 25056.2 03:38:21 INFO - PID 14157 | 03:38:21 INFO - PID 14157 | [#2] jquery.html Cycles:180 Average:37103.83 Median:22562.22 stddev:86665.70 (384.1%) stddev-sans-first:86865.38 03:38:21 INFO - PID 14157 | Values: 559.9 570.0 572.3 578.8 600.6 21635.9 22573.9 22602.7 22612.2 23054.9 22550.5 22960.8 23047.5 23083.3 23093.9 6365.3 6522.2 6542.2 6547.4 6549.4 6147.4 6352.8 6393.7 6829.7 6832.3 6819.0 6829.3 6838.2 6849.0 6851.8 6743.6 6810.6 6817.0 6828.8 6833.5 6698.1 6704.7 6712.7 6716.7 6722.8 30127.8 31583.7 31980.5 32801.8 33104.7 1927.2 1944.6 1962.1 1963.8 1970.1 20011.7 20319.8 20411.2 20438.2 20464.2 2406.8 2462.9 2519.1 2537.6 2541.3 138881.0 139362.3 141295.3 141827.0 142100.3 20051.7 21364.7 21482.6 22804.3 22959.8 42834.6 42925.6 43171.0 43453.3 43518.6 10885.1 11019.7 11034.7 11072.0 11373.8 9081.8 9124.1 9137.9 9185.0 9297.9 9077.5 11066.8 11151.4 11337.9 11801.4 3581.7 3705.6 3883.9 3936.3 4425.8 969.4 972.9 980.7 1000.2 1001.3 19031.8 19697.0 19755.4 19891.0 20574.3 1017.2 1019.6 1039.0 1040.1 1048.7 10738.3 12946.9 13631.5 13778.2 13954.4 501744.0 513964.0 514986.0 520266.0 524263.0 121447.0 123382.0 124256.4 124413.4 126020.0 1201.8 1234.0 1276.5 1278.7 1281.4 20464.6 21344.7 21466.8 21649.7 22127.3 58894.7 59690.4 62024.0 63756.4 63842.7 71275.3 73579.6 73694.3 73705.6 73987.3 14426.7 15108.0 15111.0 15134.9 15213.2 23529.8 23606.5 24560.5 24670.6 24851.3 19088.2 19431.1 19599.9 19639.3 19697.9 15538.5 15604.5 17297.3 17495.7 17746.6 19706.2 19727.3 19903.7 19916.1 19932.7 14153.3 14163.3 14388.2 14400.8 14420.0 17960.5 17969.6 18107.6 18151.8 18183.5 03:38:21 INFO - PID 14157 | 03:38:21 INFO - PID 14157 | [#3] mootools.html Cycles:180 Average:8628.17 Median:2641.16 stddev:5921.85 (224.2%) stddev-sans-first:5913.13 03:38:21 INFO - PID 14157 | Values: 1337.8 1374.8 1419.4 1420.2 1422.7 13232.2 13940.2 13944.6 13948.3 13968.6 13800.4 14159.6 14634.3 14675.9 14683.1 2673.0 2742.1 2744.0 2744.2 2744.4 2592.9 2663.9 2682.2 2726.0 2754.5 2696.9 2731.8 2733.5 2733.7 2735.2 2593.5 2616.9 2630.4 2636.0 2663.8 2610.1 2628.9 2646.3 2651.2 2651.7 13282.9 13655.2 13655.9 13670.7 13673.2 7309.2 7516.3 7563.7 7576.1 7583.1 4985.6 5034.1 5142.2 5156.2 5210.6 1718.9 1724.7 1754.8 1770.9 1781.6 23005.8 23635.5 23665.4 23689.0 23711.8 6888.6 7053.3 7188.6 7279.2 7299.7 15793.2 15901.4 15918.3 15936.4 15939.7 7464.4 7605.3 7637.7 7638.2 7652.1 6920.1 6960.4 7030.6 7043.9 7075.3 5182.5 5293.5 5327.8 5336.5 5384.4 1376.6 1420.5 1548.1 1583.2 1600.2 817.1 832.1 836.9 868.0 884.5 7474.9 7551.1 7593.1 7652.2 7653.9 952.7 976.7 977.0 989.7 990.8 4370.3 4658.3 4700.3 4762.6 4797.6 18104.2 18233.7 19002.9 19032.8 19394.9 19081.9 19233.7 19248.7 19313.4 19321.3 10257.4 10492.5 10632.9 10702.0 10739.9 7501.2 7721.5 7732.8 8042.5 8049.0 16162.8 16406.2 16883.6 16922.9 17217.3 16549.3 16977.0 17125.7 17223.3 17360.0 11254.9 11608.1 11614.5 11617.8 11618.8 13047.9 13099.8 13236.3 13289.3 13379.7 10122.9 10489.4 10656.6 10736.7 10813.7 9895.0 10359.5 10375.0 10423.0 10612.4 8638.7 8699.2 8730.1 8749.2 8758.6 6442.8 6547.7 6570.6 6609.4 6796.6 6171.4 6495.2 6516.4 6647.5 6696.8 03:38:21 INFO - PID 14157 | 03:38:21 INFO - PID 14157 | [#4] prototype.html Cycles:180 Average:5473.51 Median:6076.70 stddev:1544.63 (25.4%) stddev-sans-first:1503.02 03:38:21 INFO - PID 14157 | Values: 491.8 498.4 518.4 522.8 523.4 6140.5 6191.9 6230.6 6264.5 6313.3 5895.1 5978.3 6081.6 6128.5 6165.9 4860.6 4871.8 4904.3 4904.9 4919.9 4914.8 4917.3 4932.9 4952.5 4988.8 4720.6 4815.2 4837.0 4900.3 4911.2 4809.4 4908.2 4918.5 4938.2 4948.6 4393.1 4414.2 4420.4 4431.3 4458.3 6020.9 6042.5 6049.4 6095.6 6148.7 5610.2 5668.9 5674.3 5688.0 5717.3 6438.7 6456.4 6463.7 6519.0 6521.4 4787.6 4840.7 4847.2 4870.9 4878.7 6874.7 6887.3 6902.2 6924.4 6940.5 4907.3 4957.9 4960.2 4963.5 4990.1 5056.0 5056.0 5061.5 5067.9 5081.1 5540.3 5594.6 5688.8 5705.9 5707.2 6452.3 6453.8 6472.0 6475.8 6533.4 1641.9 1712.7 1715.6 1744.0 1752.8 1188.2 1203.4 1206.4 1218.3 1219.9 5728.6 5740.8 5777.8 5797.4 5804.5 6429.7 6569.4 6637.5 6660.2 6750.2 5686.4 5691.8 5722.5 5766.3 5809.2 3519.5 3565.3 3567.1 3576.7 3645.8 6461.9 6476.8 6517.7 6518.8 6592.5 6922.3 6935.5 6949.6 6973.8 6993.9 6383.0 6475.3 6491.9 6546.6 6567.4 6715.7 6723.6 6739.2 6770.1 6772.0 6576.8 6591.6 6658.4 6715.3 6742.0 6497.4 6515.7 6569.7 6581.9 6583.7 4905.5 4908.0 4919.9 4938.7 4966.7 6618.8 6684.5 6734.7 6751.0 6760.8 6442.4 6478.7 6518.7 6523.9 6586.8 6419.0 6420.9 6475.8 6486.4 6555.3 6071.8 6198.5 6239.1 6363.0 6444.0 6389.5 6421.7 6431.4 6434.8 6495.6 6230.5 6256.4 6279.6 6356.1 6382.2 03:38:21 INFO - PID 14157 | 03:38:21 INFO - PID 14157 | [#5] yui.html Cycles:180 Average:22344.12 Median:18759.03 stddev:30033.81 (160.1%) stddev-sans-first:30074.55 03:38:21 INFO - PID 14157 | Values: 814.3 831.2 831.4 883.7 910.7 16536.6 16928.6 17507.6 17563.8 17594.8 15099.4 18253.5 18579.2 18663.1 18782.6 1008.2 1034.7 1035.0 1035.3 1035.4 972.1 1027.5 1029.7 1030.0 1054.9 1104.4 1108.0 1110.8 1111.4 1111.9 1099.7 1104.3 1104.4 1104.6 1108.1 803.1 811.5 812.0 812.4 812.5 15697.7 15737.4 15930.3 15974.8 18944.4 20057.6 20109.4 20850.0 20867.8 21222.9 15428.3 15601.5 15814.9 15898.5 15900.4 3414.8 3439.4 3443.1 3465.1 3469.7 115359.0 123107.0 125297.0 125464.0 128319.0 15440.7 16305.3 16367.3 16391.5 16492.3 29774.0 30557.2 30577.5 30673.5 30765.7 8889.5 9147.7 9227.5 9274.8 9317.8 4294.3 4386.1 4387.5 4393.1 4397.7 4706.9 5256.1 5269.2 5410.3 6049.8 1073.3 1092.5 1115.0 1116.9 1122.1 663.8 667.8 678.2 680.1 692.8 11046.9 11500.3 11992.9 12340.5 12494.6 628.8 645.1 657.6 663.0 688.9 4914.5 4961.9 4975.7 4999.5 5119.8 100175.5 100675.5 102462.5 104234.0 105919.5 82692.0 83201.0 88830.0 91537.5 92316.5 72545.3 75050.0 76483.0 77700.6 78292.0 9648.0 9650.1 9951.3 10015.8 10068.3 34008.7 36141.0 36529.8 36567.3 36675.4 64051.4 64906.0 66310.3 66618.3 68834.7 18080.2 18366.2 18602.7 18735.4 18916.7 16866.3 20498.5 20550.3 20629.4 20795.2 17859.5 18447.5 18530.0 18579.2 18786.1 16806.5 17013.1 18358.4 18899.1 18959.0 17306.4 17482.1 17767.8 17843.2 17930.0 13388.9 13669.6 13684.7 14044.0 14087.5 13624.6 13679.3 14048.9 14193.1 14559.0 03:38:21 INFO - PID 14157 | -------- Summary: end -------- 03:38:21 INFO - PID 14157 | 03:38:21 INFO - TEST-INFO | 14157: exit 0 03:38:21 INFO - TEST-OK | dromaeo_css | took 1115158ms 03:38:21 INFO - TEST-START | kraken 03:38:21 INFO - Initialising browser for kraken test... 03:38:21 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35944/getInfo.html -profile /tmp/tmpWGG0EH/profile 03:38:21 INFO - TEST-INFO | started process 14530 (/builds/slave/test/build/application/firefox/firefox http://localhost:35944/getInfo.html) 03:38:28 INFO - TEST-INFO | 14530: exit 0 03:38:28 INFO - Browser initialized. 03:38:28 INFO - Running cycle 1/1 for kraken test... 03:38:28 INFO - TEST-INFO | started process 14753 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWGG0EH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:38:29 INFO - PID 14753 | 03:38:29 INFO - PID 14753 | (/builds/slave/test/build/application/firefox/firefox:14807): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:38:29 INFO - PID 14753 | 03:38:39 INFO - PID 14753 | RSS: Main: 174563328 03:38:39 INFO - PID 14753 | 03:38:42 INFO - PID 14753 | Cycle 1(1): loaded http://localhost:35944/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35944/tests/kraken/driver.html?testName=audio-beat-detection) 03:38:43 INFO - PID 14753 | RSS: Main: 179806208 03:38:43 INFO - PID 14753 | 03:38:46 INFO - PID 14753 | Cycle 1(1): loaded http://localhost:35944/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35944/tests/kraken/driver.html?testName=audio-dft) 03:38:47 INFO - PID 14753 | RSS: Main: 179777536 03:38:47 INFO - PID 14753 | 03:38:50 INFO - PID 14753 | Cycle 1(1): loaded http://localhost:35944/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35944/tests/kraken/driver.html?testName=audio-fft) 03:38:50 INFO - PID 14753 | RSS: Main: 174100480 03:38:50 INFO - PID 14753 | 03:38:52 INFO - PID 14753 | Cycle 1(1): loaded http://localhost:35944/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35944/tests/kraken/driver.html?testName=audio-oscillator) 03:38:53 INFO - PID 14753 | RSS: Main: 174891008 03:38:53 INFO - PID 14753 | 03:38:55 INFO - PID 14753 | Cycle 1(1): loaded http://localhost:35944/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35944/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:38:56 INFO - PID 14753 | RSS: Main: 175325184 03:38:56 INFO - PID 14753 | 03:38:59 INFO - PID 14753 | Cycle 1(1): loaded http://localhost:35944/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35944/tests/kraken/driver.html?testName=imaging-darkroom) 03:39:00 INFO - PID 14753 | RSS: Main: 177659904 03:39:00 INFO - PID 14753 | 03:39:03 INFO - PID 14753 | Cycle 1(1): loaded http://localhost:35944/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35944/tests/kraken/driver.html?testName=imaging-desaturate) 03:39:04 INFO - PID 14753 | RSS: Main: 177242112 03:39:04 INFO - PID 14753 | 03:39:07 INFO - PID 14753 | Cycle 1(1): loaded http://localhost:35944/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35944/tests/kraken/driver.html?testName=json-parse-financial) 03:39:07 INFO - PID 14753 | RSS: Main: 178413568 03:39:07 INFO - PID 14753 | 03:39:09 INFO - PID 14753 | Cycle 1(1): loaded http://localhost:35944/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35944/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:39:10 INFO - PID 14753 | RSS: Main: 178323456 03:39:10 INFO - PID 14753 | 03:39:12 INFO - PID 14753 | Cycle 1(1): loaded http://localhost:35944/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35944/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:39:12 INFO - PID 14753 | RSS: Main: 175226880 03:39:12 INFO - PID 14753 | 03:39:14 INFO - PID 14753 | Cycle 1(1): loaded http://localhost:35944/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35944/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:39:15 INFO - PID 14753 | RSS: Main: 175484928 03:39:15 INFO - PID 14753 | 03:39:18 INFO - PID 14753 | Cycle 1(1): loaded http://localhost:35944/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35944/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:39:19 INFO - PID 14753 | RSS: Main: 175656960 03:39:19 INFO - PID 14753 | 03:39:22 INFO - PID 14753 | Cycle 1(1): loaded http://localhost:35944/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35944/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:39:23 INFO - PID 14753 | RSS: Main: 175292416 03:39:23 INFO - PID 14753 | 03:39:24 INFO - PID 14753 | Cycle 1(1): loaded http://localhost:35944/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35944/tests/kraken/driver.html?testName=ai-astar) 03:39:25 INFO - PID 14753 | RSS: Main: 177283072 03:39:25 INFO - PID 14753 | 03:39:25 INFO - PID 14753 | __start_tp_report 03:39:25 INFO - PID 14753 | _x_x_mozilla_page_load 03:39:25 INFO - PID 14753 | _x_x_mozilla_page_load_details 03:39:25 INFO - PID 14753 | |i|pagename|runs| 03:39:25 INFO - PID 14753 | |0;ai-astar;107;110;103;108;109;110;111;101;108;110 03:39:25 INFO - PID 14753 | |1;audio-beat-detection;156;134;157;165;119;152;150;117;177;120 03:39:25 INFO - PID 14753 | |2;audio-dft;164;163;166;161;163;175;166;163;166;164 03:39:25 INFO - PID 14753 | |3;audio-fft;77;76;78;167;76;79;74;86;99;77 03:39:25 INFO - PID 14753 | |4;audio-oscillator;81;78;130;82;78;79;130;79;80;122 03:39:25 INFO - PID 14753 | |5;imaging-gaussian-blur;114;114;114;120;114;120;113;115;116;119 03:39:25 INFO - PID 14753 | |6;imaging-darkroom;152;149;150;153;151;151;150;150;151;151 03:39:25 INFO - PID 14753 | |7;imaging-desaturate;95;95;95;94;95;94;94;94;99;99 03:39:25 INFO - PID 14753 | |8;json-parse-financial;57;56;57;57;57;56;63;55;58;57 03:39:25 INFO - PID 14753 | |9;json-stringify-tinderbox;63;59;54;54;54;55;64;54;57;53 03:39:25 INFO - PID 14753 | |10;stanford-crypto-aes;79;89;82;80;87;78;80;79;79;79 03:39:25 INFO - PID 14753 | |11;stanford-crypto-ccm;145;130;140;129;146;138;128;135;127;171 03:39:25 INFO - PID 14753 | |12;stanford-crypto-pbkdf2;184;189;190;185;185;181;186;184;191;196 03:39:25 INFO - PID 14753 | |13;stanford-crypto-sha256-iterative;71;70;69;71;69;69;67;69;70;70 03:39:25 INFO - PID 14753 | __end_tp_report 03:39:25 INFO - PID 14753 | __start_cc_report 03:39:25 INFO - PID 14753 | _x_x_mozilla_cycle_collect,988 03:39:25 INFO - PID 14753 | __end_cc_report 03:39:25 INFO - PID 14753 | __startTimestamp1501583965134__endTimestamp 03:39:25 INFO - PID 14753 | 03:39:25 INFO - PID 14753 | ------- Summary: start ------- 03:39:25 INFO - PID 14753 | Number of tests: 14 03:39:25 INFO - PID 14753 | 03:39:25 INFO - PID 14753 | [#0] ai-astar Cycles:10 Average:107.70 Median:109.50 stddev:3.27 (3.0%) stddev-sans-first:3.46 03:39:25 INFO - PID 14753 | Values: 107.0 110.0 103.0 108.0 109.0 110.0 111.0 101.0 108.0 110.0 03:39:25 INFO - PID 14753 | 03:39:25 INFO - PID 14753 | [#1] audio-beat-detection Cycles:10 Average:144.70 Median:154.00 stddev:21.00 (13.6%) stddev-sans-first:21.87 03:39:25 INFO - PID 14753 | Values: 156.0 134.0 157.0 165.0 119.0 152.0 150.0 117.0 177.0 120.0 03:39:25 INFO - PID 14753 | 03:39:25 INFO - PID 14753 | [#2] audio-dft Cycles:10 Average:165.10 Median:165.00 stddev:3.84 (2.3%) stddev-sans-first:4.06 03:39:25 INFO - PID 14753 | Values: 164.0 163.0 166.0 161.0 163.0 175.0 166.0 163.0 166.0 164.0 03:39:25 INFO - PID 14753 | 03:39:25 INFO - PID 14753 | [#3] audio-fft Cycles:10 Average:88.90 Median:77.50 stddev:28.41 (36.7%) stddev-sans-first:29.81 03:39:25 INFO - PID 14753 | Values: 77.0 76.0 78.0 167.0 76.0 79.0 74.0 86.0 99.0 77.0 03:39:25 INFO - PID 14753 | 03:39:25 INFO - PID 14753 | [#4] audio-oscillator Cycles:10 Average:93.90 Median:79.00 stddev:23.21 (29.4%) stddev-sans-first:24.14 03:39:25 INFO - PID 14753 | Values: 81.0 78.0 130.0 82.0 78.0 79.0 130.0 79.0 80.0 122.0 03:39:25 INFO - PID 14753 | 03:39:25 INFO - PID 14753 | [#5] imaging-gaussian-blur Cycles:10 Average:115.90 Median:115.50 stddev:2.73 (2.4%) stddev-sans-first:2.80 03:39:25 INFO - PID 14753 | Values: 114.0 114.0 114.0 120.0 114.0 120.0 113.0 115.0 116.0 119.0 03:39:25 INFO - PID 14753 | 03:39:25 INFO - PID 14753 | [#6] imaging-darkroom Cycles:10 Average:150.80 Median:151.00 stddev:1.14 (0.8%) stddev-sans-first:1.12 03:39:25 INFO - PID 14753 | Values: 152.0 149.0 150.0 153.0 151.0 151.0 150.0 150.0 151.0 151.0 03:39:25 INFO - PID 14753 | 03:39:25 INFO - PID 14753 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:1.96 (2.1%) stddev-sans-first:2.07 03:39:25 INFO - PID 14753 | Values: 95.0 95.0 95.0 94.0 95.0 94.0 94.0 94.0 99.0 99.0 03:39:25 INFO - PID 14753 | 03:39:25 INFO - PID 14753 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:57.00 stddev:2.16 (3.8%) stddev-sans-first:2.29 03:39:25 INFO - PID 14753 | Values: 57.0 56.0 57.0 57.0 57.0 56.0 63.0 55.0 58.0 57.0 03:39:25 INFO - PID 14753 | 03:39:25 INFO - PID 14753 | [#9] json-stringify-tinderbox Cycles:10 Average:56.70 Median:56.00 stddev:4.00 (7.1%) stddev-sans-first:3.54 03:39:25 INFO - PID 14753 | Values: 63.0 59.0 54.0 54.0 54.0 55.0 64.0 54.0 57.0 53.0 03:39:25 INFO - PID 14753 | 03:39:25 INFO - PID 14753 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:80.00 stddev:3.77 (4.7%) stddev-sans-first:3.91 03:39:25 INFO - PID 14753 | Values: 79.0 89.0 82.0 80.0 87.0 78.0 80.0 79.0 79.0 79.0 03:39:25 INFO - PID 14753 | 03:39:25 INFO - PID 14753 | [#11] stanford-crypto-ccm Cycles:10 Average:138.90 Median:139.00 stddev:13.22 (9.5%) stddev-sans-first:13.84 03:39:25 INFO - PID 14753 | Values: 145.0 130.0 140.0 129.0 146.0 138.0 128.0 135.0 127.0 171.0 03:39:25 INFO - PID 14753 | 03:39:25 INFO - PID 14753 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.10 Median:187.50 stddev:4.38 (2.3%) stddev-sans-first:4.50 03:39:25 INFO - PID 14753 | Values: 184.0 189.0 190.0 185.0 185.0 181.0 186.0 184.0 191.0 196.0 03:39:25 INFO - PID 14753 | 03:39:25 INFO - PID 14753 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:70.00 stddev:1.18 (1.7%) stddev-sans-first:1.12 03:39:25 INFO - PID 14753 | Values: 71.0 70.0 69.0 71.0 69.0 69.0 67.0 69.0 70.0 70.0 03:39:25 INFO - PID 14753 | -------- Summary: end -------- 03:39:25 INFO - PID 14753 | 03:39:25 INFO - PID 14753 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:39:25 INFO - TEST-INFO | 14753: exit 0 03:39:26 INFO - TEST-OK | kraken | took 64492ms 03:39:26 INFO - SUITE-END | took 1179s 03:39:26 INFO - Completed test suite (00:19:39) 03:39:26 INFO - javascript benchmark 03:39:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8482.879814562859, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3126.5310203469476, 3156.1636166415888, 3157.794743341683, 3169.445347064264, 3170.4610216263245, 6113.0, 6184.010558310665, 6196.628202307859, 6223.875522489548, 6292.496600271978, 6050.697465126748, 6188.690565471731, 6189.0, 6199.194104766374, 6234.5324100692405, 5626.12795016771, 5650.689212093323, 5669.291338582677, 5672.716364181795, 5709.200711900337, 5699.458551437607, 5716.056850619663, 5723.055695810186, 5726.0552008918685, 5735.397783232763, 5682.0, 5727.341355744101, 5756.079027355624, 5779.682117483537, 5786.623869448473, 5638.943610563882, 5707.058335374658, 5716.228309178249, 5718.0, 5734.598578099555, 5403.729813509348, 5541.113421852484, 5590.944090559083, 5610.438956104398, 5629.183768353566, 5859.118476455345, 6095.695215239265, 6141.4472697456995, 6147.538934579924, 6163.845903852395, 6552.049952756824, 6605.57063790852, 6615.569987950767, 6667.633280169589, 6698.49761267902, 6649.468042556584, 6684.532082754209, 6693.598384096969, 6722.529422940396, 6763.763268285636, 6239.750409983595, 6274.466670333027, 6275.592086514362, 6282.685865706742, 6285.057241413824, 6838.247792742794, 6933.064036355128, 6938.479614028968, 6945.826354341081, 6962.2341542430295, 6489.740410383626, 6540.9672951635885, 6602.86794264112, 6609.173853268341, 6612.768553100618, 6477.4494167996245, 6530.379613936669, 6569.310222426672, 6593.076969224312, 6681.298463661343, 6563.737450502022, 6565.0, 6642.43539299165, 6648.900266496006, 6652.201735791639, 6677.699503522354, 6706.631135287606, 6715.7985260442265, 6732.932670673231, 6752.966235168793, 5340.813071542478, 5340.91988620171, 5413.485718856781, 5423.29497165366, 5426.70153141581, 4557.954420455753, 4607.3319368691355, 4634.490206077328, 4641.234196357631, 4641.582257596765, 5694.259746233046, 5762.4525670061275, 5766.163906233573, 5768.451997060272, 5776.0, 6656.5340426169705, 6666.866662666719, 6750.8649827004165, 6751.493637977172, 6754.5947243165565, 5777.537796976232, 5815.680137592389, 5823.184754134425, 5847.386024467455, 5865.589408741433, 5816.709164541756, 5824.242848429677, 5885.146653735184, 5909.438603332676, 5921.348651648315, 6312.2740884796995, 6423.582467139621, 6453.548251622436, 6524.151860258136, 6544.509161812883, 6635.071090047494, 6689.431398331197, 6693.029510721016, 6694.096296999843, 6696.7656132035145, 6365.490760739037, 6444.452221561032, 6457.031445283245, 6462.579932304385, 6475.061116138228, 6472.644004579794, 6499.935000650122, 6501.707423165874, 6508.902366464602, 6530.967345163243, 6705.061291419108, 6748.122744043243, 6749.223839258351, 6804.4896632753735, 6847.520673552804, 6439.7424103035355, 6447.097406363019, 6453.515986300952, 6552.770653027121, 6553.344665533599, 6324.557280990287, 6385.457236134795, 6419.101325814483, 6533.444657204191, 6551.246606640298, 6410.294867564471, 6427.614343139427, 6434.8391290218115, 6439.388258115471, 6451.548391612542, 6511.609303441809, 6514.54398192141, 6570.441512471302, 6583.63789991555, 6612.537122401386, 6280.497560195265, 6311.589746666452, 6321.5258855586935, 6405.327440618668, 6426.164598602152], "value": 6075.684304914893, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [805.3195050182597, 874.9737507874764, 902.9503377314245, 1126.7408496045914, 1155.353002318701, 29363.85318073409, 39866.2026759465, 40187.598124018754, 40381.79809100951, 40490.797546012225, 39300.410493842544, 39694.20611587766, 39808.60191398085, 39844.40233396494, 39857.601423985754, 7467.626618669058, 7554.999999999973, 7600.0, 7612.619369031554, 7664.846703065935, 7092.219855815856, 7543.283388078124, 7591.924080759177, 7603.923960760377, 7609.201033891445, 7540.773776786705, 7564.886526702104, 7583.090029196476, 7585.317321441069, 7598.08822941245, 7547.245275472464, 7591.734289299903, 7597.810054748647, 7600.695972161135, 7604.771856844248, 7498.587577683225, 7516.812079698051, 7525.096988361377, 7538.62306884659, 7542.886856697154, 36514.63485365139, 36766.44850327247, 36787.816060919795, 36939.63060369389, 36967.630323696685, 3477.2176260341475, 3495.2310491691787, 3518.8416521256604, 3525.576930768324, 3526.0655926179584, 29780.40439191204, 29826.85086574575, 29855.402891942256, 29900.401991960258, 29931.850340748373, 4641.3270075839155, 4859.319695242669, 4899.828506002308, 4908.067467181224, 4976.4277108132665, 187053.0, 187396.99999999863, 187989.0, 188624.0, 189080.0, 45746.31380529295, 45771.31343029857, 46223.0, 46380.53619463762, 46667.29999050017, 49229.75385123052, 49418.50581494211, 49640.0287976961, 49656.50343496591, 49728.75135624299, 14501.854981450262, 14570.05294655844, 14655.413783448543, 14657.34041968114, 14666.779998300033, 11709.180357374902, 11717.648470545897, 11735.061195104372, 11746.70633234176, 11835.822462663067, 12914.160579562298, 13215.867841321464, 14547.636309092146, 14866.0, 14880.330385132695, 5816.709164541756, 5877.4122587740885, 5916.940830591639, 5963.7912673056235, 6073.0, 983.9901600984042, 987.8616993620899, 988.7824678570703, 1018.2973748113777, 1020.4744556553381, 22703.545929081327, 22929.19747808852, 23594.410139746302, 28121.71878281191, 28878.855605721837, 1048.66442738323, 1078.7087486378634, 1090.291310648085, 1102.404701461202, 1108.3128460354633, 11474.254173478697, 11527.689057048761, 11838.704032399259, 11904.583339583072, 12100.273983560839, 214143.0, 216890.0, 217218.0, 217343.0, 217829.0, 49097.263541046916, 49142.50857491451, 49196.75401622969, 49214.0, 49278.26082608764, 1453.5711964970149, 1462.144645382442, 1484.9925750371178, 1487.5686051045075, 1503.6316102554724, 21178.894105529373, 21272.149114035266, 21293.89353053225, 21463.034163462995, 21604.0, 41273.79363103165, 43135.35296970485, 44779.0, 44858.0, 45121.323180152984, 204076.0, 206480.0, 206579.0, 206954.0, 207277.0, 34376.31247374989, 34771.65228347785, 35061.29877402489, 35092.0, 36514.0, 45055.77472112618, 45486.0, 45530.54469455263, 45580.0, 46076.7696161517, 31587.84206078955, 32485.51271730973, 32616.673833262314, 32701.509477357384, 32965.34069318648, 31237.531437028916, 31387.372252555277, 32224.516632250066, 32493.67506325001, 33092.0, 36125.27749445049, 36181.0, 36278.0, 36326.45510317294, 36632.08419789527, 30925.381492370478, 31579.210519736273, 32199.034028979167, 32328.35343293074, 32423.0, 24004.87997560001, 24058.15796447116, 24454.0, 24644.383890402165, 25056.24831255065], "value": 16990.369761211117, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.9076152434849, 569.9629524080935, 572.2789285500269, 578.8292453726153, 600.6246096189882, 21635.891820540895, 22573.887130564322, 22602.66096008559, 22612.208572699958, 23054.88472557639, 22550.548989020208, 22960.77039229607, 23047.539049219005, 23083.307500775005, 23093.884530577365, 6365.267994180682, 6522.1521202243875, 6542.182227221598, 6547.377999090078, 6549.410553050225, 6147.354527774586, 6352.809415717513, 6393.712282947278, 6829.692663830139, 6832.2826103259185, 6819.0, 6829.282925292847, 6838.179418469791, 6849.04113424121, 6851.828704282408, 6743.629100399476, 6810.5913645181445, 6817.0, 6828.760993365233, 6833.487488438363, 6698.062271282024, 6704.731810727565, 6712.731490740364, 6716.731330746764, 6722.7647032354125, 30127.849360753276, 31583.684163158305, 31980.520292195637, 32801.83599081989, 33104.6689533104, 1927.2483731344787, 1944.562473443478, 1962.1366598696527, 1963.7741659709172, 1970.1429878003114, 20011.699824502644, 20319.79680203194, 20411.183552657876, 20438.182472701075, 20464.181432742822, 2406.819488538349, 2462.9014839406404, 2519.0553542421594, 2537.619357096432, 2541.3265484646586, 138881.0, 139362.30318848442, 141295.29352353173, 141827.0, 142100.28949855288, 20051.699224511645, 21364.679529807065, 21482.61413507557, 22804.31587052391, 22959.770402296097, 42834.57165428368, 42925.570744292156, 43171.0, 43453.34819977703, 43518.56481435208, 10885.129189664807, 11019.724506887393, 11034.724131896606, 11072.0, 11373.829392559119, 9081.77295567603, 9124.133207345292, 9137.908620913706, 9185.0, 9297.860532092023, 9077.455352678728, 11066.833997490045, 11151.442427878574, 11337.943310283561, 11801.35092569917, 3581.7313701472494, 3705.5923848376656, 3883.931918722374, 3936.2605524751602, 4425.778711064434, 969.4474149734583, 972.9367591106555, 980.7401038724744, 1000.1698590170287, 1001.2540657210279, 19031.80968190328, 19697.0, 19755.40733777989, 19891.0, 20574.27990020372, 1017.2370721958531, 1019.5564929255797, 1038.99480502597, 1040.1003132290666, 1048.6853943816825, 10738.302010369302, 12946.935265323613, 13631.454741810216, 13778.242196679079, 13954.441822326993, 501744.0, 513964.0, 514986.0, 520266.0, 524263.0, 121447.0, 123382.0, 124256.37871810763, 124413.37793310976, 126020.0, 1201.8497687789027, 1233.9876601233873, 1276.5213045108085, 1278.7442511497738, 1281.3785314122456, 20464.590708185457, 21344.679829802877, 21466.785332147105, 21649.675254871505, 22127.33617991463, 58894.70552647209, 59690.40309597022, 62024.0, 63756.36243637504, 63842.68078659577, 71275.28724712686, 73579.63210184129, 73694.26305736873, 73705.63147184445, 73987.26012739804, 14426.711465770415, 15108.0, 15111.0, 15134.924325378302, 15213.163276019925, 23529.764702352757, 23606.527869442172, 24560.50878982446, 24670.62994055055, 24851.25446236616, 19088.23647054158, 19431.125599348346, 19599.902000489907, 19639.31262405809, 19697.901510492356, 15538.533843984698, 15604.531864044096, 17297.30810767555, 17495.72555567768, 17746.64506709833, 19706.21175152978, 19727.309544165884, 19903.701444478054, 19916.103775330434, 19932.70100948516, 14153.292335383396, 14163.291835408394, 14388.20864852443, 14400.783988239975, 14420.0, 17960.461186164437, 17969.550761231072, 18107.637847243244, 18151.818481815542, 18183.54541136429], "value": 12869.302181451316, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1337.839459264888, 1374.814400055992, 1419.3754747910918, 1420.1550077703762, 1422.6698037335093, 13232.206067635949, 13940.233287169202, 13944.581662550114, 13948.302584870766, 13968.58094257174, 13800.44798208073, 14159.646008849784, 14634.26828658568, 14675.926620366883, 14683.119012859235, 2672.986635066822, 2742.081402730078, 2744.0121556239837, 2744.217897899099, 2744.3962328287744, 2592.883320250584, 2663.9467210655775, 2682.208748419221, 2726.0458839406247, 2754.5454999924987, 2696.892124315025, 2731.8360898346164, 2733.521633714102, 2733.740294672003, 2735.2067900308884, 2593.48130373925, 2616.869156542175, 2630.3818602628367, 2636.037846186138, 2663.8401695898115, 2610.099515667092, 2628.8554129522868, 2646.2855029142024, 2651.164883061829, 2651.7348265173523, 13282.867171328357, 13655.180689158682, 13655.863441365558, 13670.726585468334, 13673.24797136157, 7309.195988441267, 7516.323530882247, 7563.7352692655495, 7576.0908690956885, 7583.127940286828, 4985.601151907838, 5034.0686972910125, 5142.151544995108, 5156.20078887773, 5210.557102646279, 1718.8538974187209, 1724.6550689861951, 1754.7631069805668, 1770.9026003569797, 1781.5724226185753, 23005.76994230053, 23635.527289454287, 23665.408364790845, 23689.0, 23711.762882371127, 6888.552244104118, 7053.294670533009, 7188.568685878864, 7279.235680253497, 7299.671514781848, 15793.21033948298, 15901.443449479213, 15918.283677234553, 15936.442224522318, 15939.681206375808, 7464.365528929993, 7605.277498637621, 7637.69449222036, 7638.197989211053, 7652.120006199247, 6920.100386949664, 6960.408365288906, 7030.613316267654, 7043.929560704328, 7075.292470752986, 5182.53357197854, 5293.523582877559, 5327.786888524493, 5336.546393556514, 5384.353877534642, 1376.6420730609914, 1420.46022511445, 1548.1485183149223, 1583.1688363608966, 1600.2398860541382, 817.1215942861447, 832.1054866019053, 836.8995720513577, 867.9956600216958, 884.5002573545926, 7474.887876681854, 7551.131619863676, 7593.126790419173, 7652.234776522303, 7653.885191722128, 952.6903756279237, 976.7216343342113, 976.9658061967797, 989.7129832348683, 990.7869807991173, 4370.344448332776, 4658.254679251304, 4700.271457924027, 4762.64280178988, 4797.592204662643, 18104.18531166074, 18233.7264941026, 19002.904985474983, 19032.809671903382, 19394.903025484782, 19081.904590477236, 19233.711494327596, 19248.711269330972, 19313.4205973821, 19321.323753668836, 10257.435841028815, 10492.475376231157, 10632.893671063344, 10702.0, 10739.946300268604, 7501.249875012455, 7721.53670779755, 7732.806679833049, 8042.477238979448, 8049.0, 16162.757558636395, 16406.17969101564, 16883.57791055184, 16922.915385422995, 17217.31130754756, 16549.338026478807, 16977.0, 17125.74311385355, 17223.31106755716, 17360.045197514257, 11254.887451125383, 11608.12939029593, 11614.477348519167, 11617.767644647229, 11618.825717614074, 13047.934760326138, 13099.803502947654, 13236.272005039815, 13289.335533223493, 13379.732405352033, 10122.949385253027, 10489.370637761758, 10656.57373705043, 10736.73158171052, 10813.67558973232, 9895.0, 10359.482025898826, 10375.0, 10423.0, 10612.363258204532, 8638.740837774876, 8699.173578510032, 8730.083341249077, 8749.16882896124, 8758.562071896253, 6442.8389290268115, 6547.70535325902, 6570.638614876228, 6609.372109649576, 6796.626185559644, 6171.413715697002, 6495.188101487314, 6516.380943810331, 6647.5014373921185, 6696.7656132035145], "value": 6305.529648515465, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [491.75289417067927, 498.4105804324792, 518.4400847085149, 522.8117877564074, 523.4399192863638, 6140.478059364954, 6191.938080619192, 6230.595011324261, 6264.530160237978, 6313.348393674651, 5895.145203945436, 5978.252718410199, 6081.604695694777, 6128.479079278256, 6165.876682466348, 4860.635452341088, 4871.829485967992, 4904.337914381566, 4904.877378065541, 4919.877003074916, 4914.827981020665, 4917.311576379309, 4932.901341973158, 4952.479989601094, 4988.800447982077, 4720.575148236658, 4815.205491093965, 4836.97581512092, 4900.264960255954, 4911.16510193268, 4809.446913604946, 4908.165611845995, 4918.458969513386, 4938.209886418156, 4948.554630083309, 4393.143337049277, 4414.249577571821, 4420.447444069491, 4431.33529970507, 4458.308962110878, 6020.909686354665, 6042.516598672096, 6049.364816694228, 6095.573309868311, 6148.739508400812, 5610.158476228557, 5668.914966275509, 5674.290713660793, 5687.952337158661, 5717.285339332583, 6438.742450301982, 6456.354364563553, 6463.7091330890225, 6519.0, 6521.380468855451, 4787.593054590329, 4840.733759643218, 4847.151748444008, 4870.902581948377, 4878.682885612459, 6874.69380817643, 6887.276835932205, 6902.171739391305, 6924.425837201051, 6940.514164008572, 4907.288443175719, 4957.860186744109, 4960.206366981266, 4963.478834722375, 4990.126727822617, 5056.0, 5056.0, 5061.519155680205, 5067.8986420271385, 5081.136206844845, 5540.279763630702, 5594.552435805126, 5688.800891968761, 5705.885882282331, 5707.200991861143, 6452.322506136788, 6453.838654033593, 6472.0, 6475.838104047437, 6533.379328963741, 1641.8522332990087, 1712.7174016287422, 1715.62256303613, 1743.991280043617, 1752.7905745035885, 1188.2217147768226, 1203.3682316783759, 1206.4209179593845, 1218.2751262998502, 1219.9268043917393, 5728.598998070095, 5740.799072032459, 5777.826665200051, 5797.449242321973, 5804.4775970162045, 6429.678516074177, 6569.408753212234, 6637.46900247979, 6660.167479065117, 6750.1562304711915, 5686.3744988051285, 5691.8292451226525, 5722.513586345207, 5766.336871259775, 5809.157672137517, 3519.5072689823446, 3565.3404120237838, 3567.1438854674693, 3576.6780989710533, 3645.8177091145335, 6461.93058297305, 6476.773312934119, 6517.706703198368, 6518.762804177322, 6592.472602191813, 6922.307769223037, 6935.514513983972, 6949.583025018515, 6973.803251975612, 6993.89509157363, 6382.968085159545, 6475.32009139043, 6491.870162596627, 6546.574472659262, 6567.408933196035, 6715.697793599397, 6723.596584204964, 6739.157605299338, 6770.119884414995, 6771.950347696115, 6576.8490514158875, 6591.604503729792, 6658.400743933069, 6715.294894036056, 6741.966290168518, 6497.382748638872, 6515.73937042513, 6569.671516424064, 6581.901271480836, 6583.749087673326, 4905.460399355997, 4908.0, 4919.852404427873, 4938.728369939688, 4966.726830024239, 6618.768343107968, 6684.457237664046, 6734.676536594867, 6751.0, 6760.797176084725, 6442.387973142544, 6478.740850366121, 6518.674066296761, 6523.934760652332, 6586.78144543261, 6418.967905160444, 6420.935790642034, 6475.838104047437, 6486.351364863476, 6555.311692272434, 6071.787487437919, 6198.504119670506, 6239.126522286792, 6363.0, 6444.0, 6389.52078594098, 6421.743130274736, 6431.356864313531, 6434.774782882764, 6495.570974385628, 6230.501559875109, 6256.374362563707, 6279.591826531261, 6356.09317204846, 6382.181078392636], "value": 5018.304431644115, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [814.2590242878978, 831.1605278668543, 831.3556993330168, 883.748131782442, 910.7449914024073, 16536.58658533537, 16928.57678558035, 17507.562310942216, 17563.82436175638, 17594.82405175948, 15099.396024159021, 18253.543661408472, 18579.163937622805, 18663.066846657646, 18782.624347513043, 1008.173297895724, 1034.6947650443099, 1035.0, 1035.2701345551407, 1035.3735989726183, 972.0765272990652, 1027.5119318323812, 1029.6653587584065, 1030.0214795943884, 1054.920880933933, 1104.4091411095067, 1107.9889201108006, 1110.8000559899215, 1111.4276147783899, 1111.8776934537195, 1099.74705817662, 1104.282216559235, 1104.3981030338484, 1104.5581767293068, 1108.0526150141593, 803.1406395157184, 811.4563242627395, 812.0255693168222, 812.354178428151, 812.4800127918137, 15697.68604627901, 15737.370505179779, 15930.283137258852, 15974.840251597452, 18944.431667049874, 20057.598848023103, 20109.39671809848, 20850.0, 20867.791322086738, 21222.893885530473, 15428.305726242346, 15601.531954041397, 15814.9209253953, 15898.52304430869, 15900.363985440568, 3414.8121853298057, 3439.3809114359406, 3443.1220038889924, 3465.1337165708574, 3469.7397695172963, 115359.0, 123107.0, 125297.0, 125464.0, 128319.0, 15440.691186176213, 16305.347786088661, 16367.345306187619, 16391.508254752378, 16492.34030638785, 29774.0, 30557.23606909845, 30577.541336879964, 30673.539896901566, 30765.69234307673, 8889.511076890703, 9147.679831205876, 9227.53862306882, 9274.814503709888, 9317.767055823522, 4294.26997410441, 4386.078923426053, 4387.539308372575, 4393.055493069006, 4397.692161548661, 4706.929396059062, 5256.106461901486, 5269.209618557247, 5410.323709536308, 6049.788257411057, 1073.2969904712427, 1092.5247517329988, 1115.041064684371, 1116.944487459343, 1122.1359553144196, 663.8240866170469, 667.8497338098986, 678.1658559971263, 680.1260380411148, 692.8129405060706, 11046.889531104747, 11500.309981401142, 11992.940035299942, 12340.50637974489, 12494.625161245178, 628.7642134199675, 645.106527459472, 657.5890068707058, 662.9569078009914, 688.8518968421813, 4914.459409464956, 4961.925571116436, 4975.651704380731, 4999.500049995044, 5119.795208191705, 100175.49912250538, 100675.49662251642, 102462.48768756108, 104234.0, 105919.4704026475, 82692.0, 83201.0, 88830.0, 91537.54231228802, 92316.53841730882, 72545.27454725385, 75050.0, 76483.0, 77700.61149694328, 78292.0, 9648.0, 9650.131488166098, 9951.278015141177, 10015.849762253427, 10068.295219334575, 34008.65991340055, 36141.0, 36529.81735091307, 36567.26865462623, 36675.44986825253, 64051.35948640454, 64906.0, 66310.33689663041, 66618.33381666121, 68834.65582672255, 18080.186391612147, 18366.173522191802, 18602.720959185895, 18735.437936861916, 18916.716249256, 16866.325346985985, 20498.487537811674, 20550.28074017402, 20629.381118566467, 20795.168193272704, 17859.46421607354, 18447.53881152982, 18530.0, 18579.16393762257, 18786.060696964825, 16806.495805125865, 17013.14934253307, 18358.357457488924, 18899.055047247857, 18959.0, 17306.394276200273, 17482.125893705008, 17767.822321776617, 17843.197056132765, 17930.0, 13388.866111338762, 13669.589912302647, 13684.65788355299, 14044.0, 14087.506937257147, 13624.612965056196, 13679.31603419845, 14048.859511404755, 14193.07744996572, 14558.980871338905], "value": 8863.398196028284, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1553.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 110.0, 103.0, 108.0, 109.0, 110.0, 111.0, 101.0, 108.0, 110.0], "value": 107.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 134.0, 157.0, 165.0, 119.0, 152.0, 150.0, 117.0, 177.0, 120.0], "value": 144.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 166.0, 161.0, 163.0, 175.0, 166.0, 163.0, 166.0, 164.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 78.0, 167.0, 76.0, 79.0, 74.0, 86.0, 99.0, 77.0], "value": 88.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 78.0, 130.0, 82.0, 78.0, 79.0, 130.0, 79.0, 80.0, 122.0], "value": 93.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 120.0, 114.0, 120.0, 113.0, 115.0, 116.0, 119.0], "value": 115.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 149.0, 150.0, 153.0, 151.0, 151.0, 150.0, 150.0, 151.0, 151.0], "value": 150.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 99.0, 99.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 57.0, 57.0, 57.0, 56.0, 63.0, 55.0, 58.0, 57.0], "value": 57.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 59.0, 54.0, 54.0, 54.0, 55.0, 64.0, 54.0, 57.0, 53.0], "value": 56.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 89.0, 82.0, 80.0, 87.0, 78.0, 80.0, 79.0, 79.0, 79.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 130.0, 140.0, 129.0, 146.0, 138.0, 128.0, 135.0, 127.0, 171.0], "value": 138.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 189.0, 190.0, 185.0, 185.0, 181.0, 186.0, 184.0, 191.0, 196.0], "value": 187.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 69.0, 71.0, 69.0, 69.0, 67.0, 69.0, 70.0, 70.0], "value": 69.5, "unit": "score"}]}]} 03:39:26 INFO - Return code: 0 03:39:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:39:26 INFO - # TBPL SUCCESS # 03:39:26 INFO - Running post-action listener: _package_coverage_data 03:39:26 INFO - Running post-action listener: _resource_record_post_action 03:39:26 INFO - [mozharness: 2017-08-01 10:39:26.404839Z] Finished run-tests step (success) 03:39:26 INFO - Running post-run listener: _resource_record_post_run 03:39:26 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 348160; Write bytes: 443412480; Read time: 584; Write time: 903404 03:39:26 INFO - TinderboxPrint: CPU usage
13.2% 03:39:26 INFO - TinderboxPrint: I/O read bytes / time
348,160 / 584 03:39:26 INFO - TinderboxPrint: I/O write bytes / time
443,412,480 / 903,404 03:39:26 INFO - TinderboxPrint: CPU idle
8,288.7 (86.8%) 03:39:26 INFO - TinderboxPrint: CPU user
1,206.7 (12.6%) 03:39:26 INFO - TinderboxPrint: Swap in / out
0 / 0 03:39:26 INFO - install - Wall time: 18s; CPU: 15.0%; Read bytes: 0; Write bytes: 114262016; Read time: 0; Write time: 305588 03:39:26 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:39:26 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 344064; Write bytes: 328028160; Read time: 576; Write time: 595124 03:39:27 INFO - Running post-run listener: _upload_blobber_files 03:39:27 INFO - Blob upload gear active. 03:39:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:39:27 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:39:27 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:39:27 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:39:27 INFO - (blobuploader) - INFO - Open directory for files ... 03:39:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:39:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:39:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:39:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:39:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:39:28 INFO - (blobuploader) - INFO - Done attempting. 03:39:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:39:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:39:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:39:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:39:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:39:31 INFO - (blobuploader) - INFO - Done attempting. 03:39:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:39:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:39:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:39:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:39:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:39:32 INFO - (blobuploader) - INFO - Done attempting. 03:39:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:39:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:39:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:39:33 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:39:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:39:33 INFO - (blobuploader) - INFO - Done attempting. 03:39:33 INFO - (blobuploader) - INFO - Iteration through files over. 03:39:33 INFO - Return code: 0 03:39:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:39:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:39:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/527d3b1071751050275a84f591730fe684d1f24beeb520ee82579f52b4494205eb2e454ab3dfb215042471ae4e7bc39ea0e02d4975dfabd403c41da7c4347114", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0328e6d2163a54e9d5dfc82b34845639c027e5c7a9a31b038ed9536516b59e84a9de9c9be9a4cab4c610ee704735c2f26c0e9248f7c18ed74bb1cc3c1a28014a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe09624a66083fef9c3be08570566ec0e6b7eeaca179eb2b1deb2903005d027866cbb93718da729d64f0056789f6deaec01b73247e0f4dc5ed4f764b0cb49707", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d1f41ef1696a9d7d338572c311e87e4da71cefed563124503a4e56ec408aa7f682555fd2890274bf066000aa0f53e74716f5c12e9e13defcc75036c98ba959d"} 03:39:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:39:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:39:33 INFO - Contents: 03:39:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/527d3b1071751050275a84f591730fe684d1f24beeb520ee82579f52b4494205eb2e454ab3dfb215042471ae4e7bc39ea0e02d4975dfabd403c41da7c4347114", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0328e6d2163a54e9d5dfc82b34845639c027e5c7a9a31b038ed9536516b59e84a9de9c9be9a4cab4c610ee704735c2f26c0e9248f7c18ed74bb1cc3c1a28014a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe09624a66083fef9c3be08570566ec0e6b7eeaca179eb2b1deb2903005d027866cbb93718da729d64f0056789f6deaec01b73247e0f4dc5ed4f764b0cb49707", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d1f41ef1696a9d7d338572c311e87e4da71cefed563124503a4e56ec408aa7f682555fd2890274bf066000aa0f53e74716f5c12e9e13defcc75036c98ba959d"} 03:39:33 INFO - Running post-run listener: copy_logs_to_upload_dir 03:39:33 INFO - Copying logs to upload dir... 03:39:33 INFO - mkdir: /builds/slave/test/build/upload/logs 03:39:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.975877 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-08-01 03:39:33.588210) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-01 03:39:33.595941) ========= 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=8783db0840cc980e80bb0bd400000236-1501580608.527675-1844214705 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/527d3b1071751050275a84f591730fe684d1f24beeb520ee82579f52b4494205eb2e454ab3dfb215042471ae4e7bc39ea0e02d4975dfabd403c41da7c4347114", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0328e6d2163a54e9d5dfc82b34845639c027e5c7a9a31b038ed9536516b59e84a9de9c9be9a4cab4c610ee704735c2f26c0e9248f7c18ed74bb1cc3c1a28014a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe09624a66083fef9c3be08570566ec0e6b7eeaca179eb2b1deb2903005d027866cbb93718da729d64f0056789f6deaec01b73247e0f4dc5ed4f764b0cb49707", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d1f41ef1696a9d7d338572c311e87e4da71cefed563124503a4e56ec408aa7f682555fd2890274bf066000aa0f53e74716f5c12e9e13defcc75036c98ba959d"} build_url:https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011340 build_url: 'https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/527d3b1071751050275a84f591730fe684d1f24beeb520ee82579f52b4494205eb2e454ab3dfb215042471ae4e7bc39ea0e02d4975dfabd403c41da7c4347114", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0328e6d2163a54e9d5dfc82b34845639c027e5c7a9a31b038ed9536516b59e84a9de9c9be9a4cab4c610ee704735c2f26c0e9248f7c18ed74bb1cc3c1a28014a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe09624a66083fef9c3be08570566ec0e6b7eeaca179eb2b1deb2903005d027866cbb93718da729d64f0056789f6deaec01b73247e0f4dc5ed4f764b0cb49707", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d1f41ef1696a9d7d338572c311e87e4da71cefed563124503a4e56ec408aa7f682555fd2890274bf066000aa0f53e74716f5c12e9e13defcc75036c98ba959d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-01 03:39:33.622602) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 03:39:33.622884) ========= 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=8783db0840cc980e80bb0bd400000236-1501580608.527675-1844214705 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004438 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 03:39:33.705106) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-01 03:39:33.705375) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-01 03:39:33.708640) ========= ========= Total master_lag: 0.18 =========