builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-075 starttime: 1500743309.88 results: success (0) revision: c22502562670e5e53bea543a3ee25c81f1a7b624 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-22 10:08:29.881229) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-22 10:08:29.882032) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-22 10:08:29.882439) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-22 10:08:29.900799) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 10:08:29.901454) ========= 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=fcadb68e09dcf59683000ff6000001dc-1500738863.498441-438096369 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-22 10:08:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.6M=0s 2017-07-22 10:08:30 (45.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123695 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 10:08:30.043677) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 10:08:30.044019) ========= 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=fcadb68e09dcf59683000ff6000001dc-1500738863.498441-438096369 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021632 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 10:08:30.096518) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-22 10:08:30.096882) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c22502562670e5e53bea543a3ee25c81f1a7b624 --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 c22502562670e5e53bea543a3ee25c81f1a7b624 --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=fcadb68e09dcf59683000ff6000001dc-1500738863.498441-438096369 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-22 10:08:30,784 truncating revision to first 12 chars 2017-07-22 10:08:30,784 Setting DEBUG logging. 2017-07-22 10:08:30,785 attempt 1/10 2017-07-22 10:08:30,785 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c22502562670?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-22 10:08:31,754 unpacking tar archive at: mozilla-central-c22502562670/testing/mozharness/ program finished with exit code 0 elapsedTime=1.373102 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-22 10:08:31.482420) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-22 10:08:31.482735) ========= script_repo_revision: c22502562670e5e53bea543a3ee25c81f1a7b624 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-22 10:08:31.483094) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-22 10:08:31.483360) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-22 10:08:31.491741) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-07-22 10:08:31.492012) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fcadb68e09dcf59683000ff6000001dc-1500738863.498441-438096369 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:08:32 INFO - MultiFileLogger online at 20170722 10:08:32 in /builds/slave/test 10:08:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 10:08:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:08:32 INFO - {'append_to_log': False, 10:08:32 INFO - 'base_work_dir': '/builds/slave/test', 10:08:32 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 10:08:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:08:32 INFO - 'branch': 'Firefox-Non-PGO', 10:08:32 INFO - 'buildbot_json_path': 'buildprops.json', 10:08:32 INFO - 'code_coverage': False, 10:08:32 INFO - 'config_files': ('talos/linux_config.py',), 10:08:32 INFO - 'default_actions': ('clobber', 10:08:32 INFO - 'read-buildbot-config', 10:08:32 INFO - 'download-and-extract', 10:08:32 INFO - 'populate-webroot', 10:08:32 INFO - 'create-virtualenv', 10:08:32 INFO - 'install', 10:08:32 INFO - 'setup-mitmproxy', 10:08:32 INFO - 'run-tests'), 10:08:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:08:32 INFO - 'disable_ccov_upload': False, 10:08:32 INFO - 'download_minidump_stackwalk': True, 10:08:32 INFO - 'download_symbols': 'ondemand', 10:08:32 INFO - 'enable_stylo': False, 10:08:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:08:32 INFO - 'tooltool.py': '/tools/tooltool.py', 10:08:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:08:32 INFO - '/tools/misc-python/virtualenv.py')}, 10:08:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:08:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:08:32 INFO - 'gecko_profile': False, 10:08:32 INFO - 'gecko_profile_interval': 0, 10:08:32 INFO - 'installer_path': 'installer.exe', 10:08:32 INFO - 'log_level': 'info', 10:08:32 INFO - 'log_name': 'talos', 10:08:32 INFO - 'log_to_console': True, 10:08:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:08:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:08:32 INFO - 'opt_config_files': (), 10:08:32 INFO - 'pip_index': False, 10:08:32 INFO - 'suite': 'dromaeojs-e10s', 10:08:32 INFO - 'system_bits': '32', 10:08:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:08:32 INFO - 'title': 'talos-linux64-ix-075', 10:08:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:08:32 INFO - 'use_talos_json': True, 10:08:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:08:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:08:32 INFO - 'work_dir': 'build'} 10:08:32 INFO - [mozharness: 2017-07-22 17:08:32.279756Z] Running clobber step. 10:08:32 INFO - Running pre-action listener: _resource_record_pre_action 10:08:32 INFO - Running main action method: clobber 10:08:32 INFO - rmtree: /builds/slave/test/build 10:08:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:08:33 INFO - Running post-action listener: _resource_record_post_action 10:08:33 INFO - [mozharness: 2017-07-22 17:08:33.829426Z] Finished clobber step (success) 10:08:33 INFO - [mozharness: 2017-07-22 17:08:33.829538Z] Running read-buildbot-config step. 10:08:33 INFO - Running pre-action listener: _resource_record_pre_action 10:08:33 INFO - Running main action method: read_buildbot_config 10:08:33 INFO - Using buildbot properties: 10:08:33 INFO - { 10:08:33 INFO - "project": "", 10:08:33 INFO - "product": "firefox", 10:08:33 INFO - "who": "ffxbld@noreply.mozilla.org", 10:08:33 INFO - "installer_path": "public/build/target.tar.bz2", 10:08:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 10:08:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 10:08:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 10:08:33 INFO - "stage_platform": "linux64", 10:08:33 INFO - "basedir": "/builds/slave/test", 10:08:33 INFO - "buildnumber": 1029, 10:08:33 INFO - "platform": "ubuntu64_hw", 10:08:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:08:33 INFO - "slavebuilddir": "test", 10:08:33 INFO - "taskId": "UazP3IpARJiNqIEYo0TGzg", 10:08:33 INFO - "branch": "mozilla-central", 10:08:33 INFO - "script_repo_revision": "production", 10:08:33 INFO - "revision": "c22502562670e5e53bea543a3ee25c81f1a7b624", 10:08:33 INFO - "slavename": "talos-linux64-ix-075", 10:08:33 INFO - "repo_path": "mozilla-central" 10:08:33 INFO - } 10:08:33 INFO - Finding installer, test and symbols from parent task. 10:08:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UazP3IpARJiNqIEYo0TGzg'}, attempt #1 10:08:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UazP3IpARJiNqIEYo0TGzg'}, attempt #1 10:08:34 INFO - Task dependencies: Pp1sd-lkQXyYNmBkPeE-0w 10:08:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pp1sd-lkQXyYNmBkPeE-0w'}, attempt #1 10:08:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Pp1sd-lkQXyYNmBkPeE-0w/artifacts/public/build/target.tar.bz2 10:08:35 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Pp1sd-lkQXyYNmBkPeE-0w/artifacts/public/build/test_packages.json 10:08:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Pp1sd-lkQXyYNmBkPeE-0w/artifacts/public/build/target.crashreporter-symbols.zip 10:08:35 INFO - Running post-action listener: _resource_record_post_action 10:08:35 INFO - [mozharness: 2017-07-22 17:08:35.179225Z] Finished read-buildbot-config step (success) 10:08:35 INFO - [mozharness: 2017-07-22 17:08:35.179445Z] Running download-and-extract step. 10:08:35 INFO - Running pre-action listener: _resource_record_pre_action 10:08:35 INFO - Running main action method: download_and_extract 10:08:35 INFO - mkdir: /builds/slave/test/build/tests 10:08:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:35 INFO - trying https://queue.taskcluster.net/v1/task/Pp1sd-lkQXyYNmBkPeE-0w/artifacts/public/build/target.test_packages.json 10:08:35 INFO - Downloading https://queue.taskcluster.net/v1/task/Pp1sd-lkQXyYNmBkPeE-0w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 10:08:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pp1sd-lkQXyYNmBkPeE-0w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 10:08:35 INFO - Downloaded 989 bytes. 10:08:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:08:35 INFO - Using the following test package requirements: 10:08:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 10:08:35 INFO - u'common': [u'target.common.tests.zip'], 10:08:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:08:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:08:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:08:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:08:35 INFO - u'mozbase': [u'target.common.tests.zip'], 10:08:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:08:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:08:35 INFO - u'web-platform': [u'target.common.tests.zip', 10:08:35 INFO - u'target.web-platform.tests.tar.gz'], 10:08:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:08:35 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 10:08:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Pp1sd-lkQXyYNmBkPeE-0w/artifacts/public/build/target.common.tests.zip 10:08:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pp1sd-lkQXyYNmBkPeE-0w/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:08:35 INFO - Fetch https://queue.taskcluster.net/v1/task/Pp1sd-lkQXyYNmBkPeE-0w/artifacts/public/build/target.common.tests.zip into memory 10:08:36 INFO - Content-Length response header: 72760935 10:08:36 INFO - Bytes received: 72760935 10:08:48 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 10:08:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Pp1sd-lkQXyYNmBkPeE-0w/artifacts/public/build/target.common.tests.zip 10:08:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pp1sd-lkQXyYNmBkPeE-0w/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:08:48 INFO - Fetch https://queue.taskcluster.net/v1/task/Pp1sd-lkQXyYNmBkPeE-0w/artifacts/public/build/target.common.tests.zip into memory 10:08:49 INFO - Content-Length response header: 72760935 10:08:49 INFO - Bytes received: 72760935 10:09:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Pp1sd-lkQXyYNmBkPeE-0w/artifacts/public/build/target.talos.tests.zip 10:09:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pp1sd-lkQXyYNmBkPeE-0w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:09:01 INFO - Fetch https://queue.taskcluster.net/v1/task/Pp1sd-lkQXyYNmBkPeE-0w/artifacts/public/build/target.talos.tests.zip into memory 10:09:02 INFO - Content-Length response header: 14498826 10:09:02 INFO - Bytes received: 14498826 10:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:02 INFO - trying https://queue.taskcluster.net/v1/task/Pp1sd-lkQXyYNmBkPeE-0w/artifacts/public/build/target.tar.bz2 10:09:02 INFO - Downloading https://queue.taskcluster.net/v1/task/Pp1sd-lkQXyYNmBkPeE-0w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:09:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pp1sd-lkQXyYNmBkPeE-0w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:09:03 INFO - Downloaded 61997706 bytes. 10:09:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Pp1sd-lkQXyYNmBkPeE-0w/artifacts/public/build/target.tar.bz2 10:09:03 INFO - mkdir: /builds/slave/test/properties 10:09:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:09:03 INFO - Writing to file /builds/slave/test/properties/build_url 10:09:03 INFO - Contents: 10:09:03 INFO - build_url:https://queue.taskcluster.net/v1/task/Pp1sd-lkQXyYNmBkPeE-0w/artifacts/public/build/target.tar.bz2 10:09:03 INFO - Running post-action listener: _resource_record_post_action 10:09:03 INFO - Running post-action listener: set_extra_try_arguments 10:09:03 INFO - [mozharness: 2017-07-22 17:09:03.555998Z] Finished download-and-extract step (success) 10:09:03 INFO - [mozharness: 2017-07-22 17:09:03.556095Z] Running populate-webroot step. 10:09:03 INFO - Running pre-action listener: _resource_record_pre_action 10:09:03 INFO - Running main action method: populate_webroot 10:09:03 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:09:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:09:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:09:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:09:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:09:03 INFO - 'tests': ['damp', 'tps']}, 10:09:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:09:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:09:03 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 10:09:03 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 10:09:03 INFO - 'other-e10s': {'tests': ['a11yr', 10:09:03 INFO - 'ts_paint', 10:09:03 INFO - 'tpaint', 10:09:03 INFO - 'sessionrestore', 10:09:03 INFO - 'sessionrestore_many_windows', 10:09:03 INFO - 'sessionrestore_no_auto_restore', 10:09:03 INFO - 'tabpaint']}, 10:09:03 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 10:09:03 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 10:09:03 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:09:03 INFO - 'talos_options': ['--mitmproxy', 10:09:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:09:03 INFO - '--firstNonBlankPaint'], 10:09:03 INFO - 'tests': ['quantum_pageload_google', 10:09:03 INFO - 'quantum_pageload_youtube', 10:09:03 INFO - 'quantum_pageload_amazon', 10:09:03 INFO - 'quantum_pageload_facebook']}, 10:09:03 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:09:03 INFO - 'talos_options': ['--stylo', 10:09:03 INFO - '--mitmproxy', 10:09:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:09:03 INFO - '--firstNonBlankPaint'], 10:09:03 INFO - 'tests': ['quantum_pageload_google', 10:09:03 INFO - 'quantum_pageload_youtube', 10:09:03 INFO - 'quantum_pageload_amazon', 10:09:03 INFO - 'quantum_pageload_facebook']}, 10:09:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:09:03 INFO - 'tsvgr_opacity', 10:09:03 INFO - 'tart', 10:09:03 INFO - 'tscrollx', 10:09:03 INFO - 'cart', 10:09:03 INFO - 'tsvg_static']}, 10:09:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:09:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:09:03 INFO - 'talos_options': ['--xperf_path', 10:09:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:09:03 INFO - 'tests': ['tp5n']}}} 10:09:03 INFO - Running post-action listener: _resource_record_post_action 10:09:03 INFO - [mozharness: 2017-07-22 17:09:03.563427Z] Finished populate-webroot step (success) 10:09:03 INFO - [mozharness: 2017-07-22 17:09:03.563517Z] Running create-virtualenv step. 10:09:03 INFO - Running pre-action listener: _resource_record_pre_action 10:09:03 INFO - Running main action method: create_virtualenv 10:09:03 INFO - Creating virtualenv /builds/slave/test/build/venv 10:09:03 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 10:09:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:09:03 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 10:09:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:09:03 INFO - Using real prefix '/usr' 10:09:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:09:04 INFO - Installing distribute.............................................................................................................................................................................................done. 10:09:06 INFO - Installing pip.................done. 10:09:06 INFO - Return code: 0 10:09:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:09:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:09:06 INFO - Reading from file tmpfile_stdout 10:09:06 INFO - Output received: 10:09:06 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 10:09:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2573a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2716d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2713eb0>, '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 0x2714db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2715240>, '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': 'fcadb68e09dcf59683000ff6000001dc-1500738863.498441-438096369', '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 10:09:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:09:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:09:06 INFO - Using env: {'DISPLAY': ':0', 10:09:06 INFO - 'HOME': '/home/cltbld', 10:09:06 INFO - 'LANG': 'en_US.UTF-8', 10:09:06 INFO - 'LANGUAGE': 'en_US:en', 10:09:06 INFO - 'LOGNAME': 'cltbld', 10:09:06 INFO - 'MAIL': '/var/mail/cltbld', 10:09:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:06 INFO - 'MOZ_NO_REMOTE': '1', 10:09:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:06 INFO - 'NO_EM_RESTART': '1', 10:09:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:06 INFO - 'PWD': '/builds/slave/test', 10:09:06 INFO - 'SHELL': '/bin/bash', 10:09:06 INFO - 'SHLVL': '1', 10:09:06 INFO - 'TERM': 'linux', 10:09:06 INFO - 'TMOUT': '86400', 10:09:06 INFO - 'USER': 'cltbld', 10:09:06 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1500738863.498441-438096369', 10:09:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:06 INFO - '_': '/tools/buildbot/bin/python'} 10:09:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:06 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 10:09:06 INFO - Cleaning up... 10:09:06 INFO - Return code: 0 10:09:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x23a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2573a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2716d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2713eb0>, '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 0x2714db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2715240>, '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': 'fcadb68e09dcf59683000ff6000001dc-1500738863.498441-438096369', '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 10:09:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:09:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:09:06 INFO - Using env: {'DISPLAY': ':0', 10:09:06 INFO - 'HOME': '/home/cltbld', 10:09:06 INFO - 'LANG': 'en_US.UTF-8', 10:09:06 INFO - 'LANGUAGE': 'en_US:en', 10:09:06 INFO - 'LOGNAME': 'cltbld', 10:09:06 INFO - 'MAIL': '/var/mail/cltbld', 10:09:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:06 INFO - 'MOZ_NO_REMOTE': '1', 10:09:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:06 INFO - 'NO_EM_RESTART': '1', 10:09:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:06 INFO - 'PWD': '/builds/slave/test', 10:09:06 INFO - 'SHELL': '/bin/bash', 10:09:06 INFO - 'SHLVL': '1', 10:09:06 INFO - 'TERM': 'linux', 10:09:06 INFO - 'TMOUT': '86400', 10:09:06 INFO - 'USER': 'cltbld', 10:09:06 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1500738863.498441-438096369', 10:09:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:06 INFO - '_': '/tools/buildbot/bin/python'} 10:09:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:06 INFO - Downloading/unpacking psutil>=3.1.1 10:09:06 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 10:09:06 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 10:09:06 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 10:09:06 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 10:09:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:09:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:09:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:09:07 INFO - Installing collected packages: psutil 10:09:07 INFO - Running setup.py install for psutil 10:09:08 INFO - building 'psutil._psutil_linux' extension 10:09:08 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 10:09:08 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 10:09:08 INFO - building 'psutil._psutil_posix' extension 10:09:08 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 10:09:08 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 10:09:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:09:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:09:08 INFO - Successfully installed psutil 10:09:08 INFO - Cleaning up... 10:09:08 INFO - Return code: 0 10:09:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:09:08 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')]} 10:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:08 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')]} 10:09:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:08 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 0x23a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2573a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2716d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2713eb0>, '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 0x2714db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2715240>, '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': 'fcadb68e09dcf59683000ff6000001dc-1500738863.498441-438096369', '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 10:09:08 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 10:09:08 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 10:09:08 INFO - Using env: {'DISPLAY': ':0', 10:09:08 INFO - 'HOME': '/home/cltbld', 10:09:08 INFO - 'LANG': 'en_US.UTF-8', 10:09:08 INFO - 'LANGUAGE': 'en_US:en', 10:09:08 INFO - 'LOGNAME': 'cltbld', 10:09:08 INFO - 'MAIL': '/var/mail/cltbld', 10:09:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:08 INFO - 'MOZ_NO_REMOTE': '1', 10:09:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:08 INFO - 'NO_EM_RESTART': '1', 10:09:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:08 INFO - 'PWD': '/builds/slave/test', 10:09:08 INFO - 'SHELL': '/bin/bash', 10:09:08 INFO - 'SHLVL': '1', 10:09:08 INFO - 'TERM': 'linux', 10:09:08 INFO - 'TMOUT': '86400', 10:09:08 INFO - 'USER': 'cltbld', 10:09:08 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1500738863.498441-438096369', 10:09:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:08 INFO - '_': '/tools/buildbot/bin/python'} 10:09:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:09:08 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 10:09:08 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 10:09:08 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 10:09:08 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 10:09:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:09:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:09:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:09:09 INFO - Installing collected packages: mozsystemmonitor 10:09:09 INFO - Running setup.py install for mozsystemmonitor 10:09:09 INFO - Successfully installed mozsystemmonitor 10:09:09 INFO - Cleaning up... 10:09:09 INFO - Return code: 0 10:09:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:09:09 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')]} 10:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:09 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')]} 10:09:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09: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', '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 0x23a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2573a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2716d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2713eb0>, '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 0x2714db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2715240>, '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': 'fcadb68e09dcf59683000ff6000001dc-1500738863.498441-438096369', '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 10:09: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:09: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 jsonschema==2.5.1 10:09:10 INFO - Using env: {'DISPLAY': ':0', 10:09:10 INFO - 'HOME': '/home/cltbld', 10:09:10 INFO - 'LANG': 'en_US.UTF-8', 10:09:10 INFO - 'LANGUAGE': 'en_US:en', 10:09:10 INFO - 'LOGNAME': 'cltbld', 10:09:10 INFO - 'MAIL': '/var/mail/cltbld', 10:09:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:10 INFO - 'MOZ_NO_REMOTE': '1', 10:09:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:10 INFO - 'NO_EM_RESTART': '1', 10:09:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:10 INFO - 'PWD': '/builds/slave/test', 10:09:10 INFO - 'SHELL': '/bin/bash', 10:09:10 INFO - 'SHLVL': '1', 10:09:10 INFO - 'TERM': 'linux', 10:09:10 INFO - 'TMOUT': '86400', 10:09:10 INFO - 'USER': 'cltbld', 10:09:10 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1500738863.498441-438096369', 10:09:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:10 INFO - '_': '/tools/buildbot/bin/python'} 10:09:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:10 INFO - Downloading/unpacking jsonschema==2.5.1 10:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:09:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:09: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 10:09: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 10:09: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 10:09: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 10:09:11 INFO - Downloading functools32-3.2.3-2.tar.gz 10:09:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:09:11 INFO - warning: no files found matching '*.txt' 10:09:11 INFO - no previously-included directories found matching 'build' 10:09:11 INFO - no previously-included directories found matching 'dist' 10:09:11 INFO - no previously-included directories found matching '.git*' 10:09:11 INFO - Installing collected packages: jsonschema, functools32 10:09:11 INFO - Running setup.py install for functools32 10:09:11 INFO - warning: no files found matching '*.txt' 10:09:11 INFO - no previously-included directories found matching 'build' 10:09:11 INFO - no previously-included directories found matching 'dist' 10:09:11 INFO - no previously-included directories found matching '.git*' 10:09:11 INFO - Successfully installed jsonschema functools32 10:09:11 INFO - Cleaning up... 10:09:11 INFO - Return code: 0 10:09:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:09: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')]} 10:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09: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')]} 10:09:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09: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', '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 0x23a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2573a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2716d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2713eb0>, '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 0x2714db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2715240>, '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': 'fcadb68e09dcf59683000ff6000001dc-1500738863.498441-438096369', '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 10:09: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:09: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 functools32==3.2.3-2 10:09:11 INFO - Using env: {'DISPLAY': ':0', 10:09:11 INFO - 'HOME': '/home/cltbld', 10:09:11 INFO - 'LANG': 'en_US.UTF-8', 10:09:11 INFO - 'LANGUAGE': 'en_US:en', 10:09:11 INFO - 'LOGNAME': 'cltbld', 10:09:11 INFO - 'MAIL': '/var/mail/cltbld', 10:09:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:11 INFO - 'MOZ_NO_REMOTE': '1', 10:09:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:11 INFO - 'NO_EM_RESTART': '1', 10:09:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:11 INFO - 'PWD': '/builds/slave/test', 10:09:11 INFO - 'SHELL': '/bin/bash', 10:09:11 INFO - 'SHLVL': '1', 10:09:11 INFO - 'TERM': 'linux', 10:09:11 INFO - 'TMOUT': '86400', 10:09:11 INFO - 'USER': 'cltbld', 10:09:11 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1500738863.498441-438096369', 10:09:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:11 INFO - '_': '/tools/buildbot/bin/python'} 10:09:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:09:11 INFO - Cleaning up... 10:09:11 INFO - Return code: 0 10:09:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:09: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')]} 10:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09: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')]} 10:09:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09: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', '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 0x23a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2573a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2716d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2713eb0>, '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 0x2714db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2715240>, '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': 'fcadb68e09dcf59683000ff6000001dc-1500738863.498441-438096369', '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 10:09: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:09: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 blobuploader==1.2.4 10:09:11 INFO - Using env: {'DISPLAY': ':0', 10:09:11 INFO - 'HOME': '/home/cltbld', 10:09:11 INFO - 'LANG': 'en_US.UTF-8', 10:09:11 INFO - 'LANGUAGE': 'en_US:en', 10:09:11 INFO - 'LOGNAME': 'cltbld', 10:09:11 INFO - 'MAIL': '/var/mail/cltbld', 10:09:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:11 INFO - 'MOZ_NO_REMOTE': '1', 10:09:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:11 INFO - 'NO_EM_RESTART': '1', 10:09:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:11 INFO - 'PWD': '/builds/slave/test', 10:09:11 INFO - 'SHELL': '/bin/bash', 10:09:11 INFO - 'SHLVL': '1', 10:09:11 INFO - 'TERM': 'linux', 10:09:11 INFO - 'TMOUT': '86400', 10:09:11 INFO - 'USER': 'cltbld', 10:09:11 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1500738863.498441-438096369', 10:09:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:11 INFO - '_': '/tools/buildbot/bin/python'} 10:09:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:12 INFO - Downloading/unpacking blobuploader==1.2.4 10:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:13 INFO - Downloading blobuploader-1.2.4.tar.gz 10:09:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:09:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:09: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 10:09: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 10:09: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 10:09: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 10:09:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:09:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:09: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 10:09: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 10:09: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 10:09: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 10:09:13 INFO - Downloading docopt-0.6.1.tar.gz 10:09:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:09:13 INFO - Installing collected packages: blobuploader, requests, docopt 10:09:13 INFO - Running setup.py install for blobuploader 10:09:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:09:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:09:13 INFO - Running setup.py install for requests 10:09:14 INFO - Running setup.py install for docopt 10:09:14 INFO - Successfully installed blobuploader requests docopt 10:09:14 INFO - Cleaning up... 10:09:14 INFO - Return code: 0 10:09:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:09: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')]} 10:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09: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')]} 10:09:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:14 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 0x23a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2573a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2716d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2713eb0>, '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 0x2714db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2715240>, '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': 'fcadb68e09dcf59683000ff6000001dc-1500738863.498441-438096369', '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 10:09:14 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 10:09:14 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 10:09:14 INFO - Using env: {'DISPLAY': ':0', 10:09:14 INFO - 'HOME': '/home/cltbld', 10:09:14 INFO - 'LANG': 'en_US.UTF-8', 10:09:14 INFO - 'LANGUAGE': 'en_US:en', 10:09:14 INFO - 'LOGNAME': 'cltbld', 10:09:14 INFO - 'MAIL': '/var/mail/cltbld', 10:09:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:14 INFO - 'MOZ_NO_REMOTE': '1', 10:09:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:14 INFO - 'NO_EM_RESTART': '1', 10:09:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:14 INFO - 'PWD': '/builds/slave/test', 10:09:14 INFO - 'SHELL': '/bin/bash', 10:09:14 INFO - 'SHLVL': '1', 10:09:14 INFO - 'TERM': 'linux', 10:09:14 INFO - 'TMOUT': '86400', 10:09:14 INFO - 'USER': 'cltbld', 10:09:14 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1500738863.498441-438096369', 10:09:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:14 INFO - '_': '/tools/buildbot/bin/python'} 10:09:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:09:14 INFO - Running setup.py (path:/tmp/pip-tgypak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:09:14 INFO - Running setup.py (path:/tmp/pip-L0hosZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:09:14 INFO - Running setup.py (path:/tmp/pip-rbOLP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:09:14 INFO - Running setup.py (path:/tmp/pip-1rj4Or-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:09:14 INFO - Running setup.py (path:/tmp/pip-uhPW8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:09:14 INFO - Running setup.py (path:/tmp/pip-hCgCxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:09:15 INFO - Running setup.py (path:/tmp/pip-3kKT_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:09:15 INFO - Running setup.py (path:/tmp/pip-sf0FOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:09:15 INFO - Running setup.py (path:/tmp/pip-ozkoSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:09:15 INFO - Running setup.py (path:/tmp/pip-2lVWRK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:09:15 INFO - Running setup.py (path:/tmp/pip-31wOzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:09:15 INFO - Running setup.py (path:/tmp/pip-5KpZmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:09:15 INFO - Running setup.py (path:/tmp/pip-kZKult-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:09:15 INFO - Running setup.py (path:/tmp/pip-hlh8LI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:09:15 INFO - Running setup.py (path:/tmp/pip-YI0bwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:09:15 INFO - Running setup.py (path:/tmp/pip-0tb3AB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:09:15 INFO - Running setup.py (path:/tmp/pip-CzPyQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:09:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:09:15 INFO - Running setup.py install for manifestparser 10:09:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:09:15 INFO - Running setup.py install for mozcrash 10:09:16 INFO - Running setup.py install for mozdebug 10:09:16 INFO - Running setup.py install for mozdevice 10:09:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:09:16 INFO - Running setup.py install for mozfile 10:09:16 INFO - Running setup.py install for mozhttpd 10:09:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:09:16 INFO - Running setup.py install for mozinfo 10:09:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:09:16 INFO - Running setup.py install for mozInstall 10:09:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:09:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:09:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:09:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:09:16 INFO - Running setup.py install for mozleak 10:09:16 INFO - Running setup.py install for mozlog 10:09:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:09:16 INFO - Running setup.py install for moznetwork 10:09:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:09:16 INFO - Running setup.py install for mozprocess 10:09:17 INFO - Running setup.py install for mozprofile 10:09:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:09:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:09:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:09:17 INFO - Running setup.py install for mozrunner 10:09:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:09:17 INFO - Running setup.py install for mozscreenshot 10:09:17 INFO - Running setup.py install for moztest 10:09:17 INFO - Running setup.py install for mozversion 10:09:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:09:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:09:17 INFO - Cleaning up... 10:09:17 INFO - Return code: 0 10:09:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:09:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:17 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 0x23a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2573a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2716d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2713eb0>, '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 0x2714db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2715240>, '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': 'fcadb68e09dcf59683000ff6000001dc-1500738863.498441-438096369', '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 10:09:17 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 10:09:17 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 10:09:17 INFO - Using env: {'DISPLAY': ':0', 10:09:17 INFO - 'HOME': '/home/cltbld', 10:09:17 INFO - 'LANG': 'en_US.UTF-8', 10:09:17 INFO - 'LANGUAGE': 'en_US:en', 10:09:17 INFO - 'LOGNAME': 'cltbld', 10:09:17 INFO - 'MAIL': '/var/mail/cltbld', 10:09:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:17 INFO - 'MOZ_NO_REMOTE': '1', 10:09:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:17 INFO - 'NO_EM_RESTART': '1', 10:09:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:17 INFO - 'PWD': '/builds/slave/test', 10:09:17 INFO - 'SHELL': '/bin/bash', 10:09:17 INFO - 'SHLVL': '1', 10:09:17 INFO - 'TERM': 'linux', 10:09:17 INFO - 'TMOUT': '86400', 10:09:17 INFO - 'USER': 'cltbld', 10:09:17 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1500738863.498441-438096369', 10:09:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:17 INFO - '_': '/tools/buildbot/bin/python'} 10:09:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:09:17 INFO - Running setup.py (path:/tmp/pip-RXd_J7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:09:17 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)) 10:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:09:17 INFO - Running setup.py (path:/tmp/pip-1jFDtN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:09:17 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)) 10:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:09:17 INFO - Running setup.py (path:/tmp/pip-oPSDi7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:09:18 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)) 10:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:09:18 INFO - Running setup.py (path:/tmp/pip-sVc5Cp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:09:18 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)) 10:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:09:18 INFO - Running setup.py (path:/tmp/pip-vdwJoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:09:18 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)) 10:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:09:18 INFO - Running setup.py (path:/tmp/pip-6hgOD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:09:18 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)) 10:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:09:18 INFO - Running setup.py (path:/tmp/pip-W0LWvk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:09:18 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)) 10:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:09:18 INFO - Running setup.py (path:/tmp/pip-aE8i7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:09:18 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)) 10:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:09:18 INFO - Running setup.py (path:/tmp/pip-9J7CFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:09:18 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)) 10:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:09:18 INFO - Running setup.py (path:/tmp/pip-MhLJck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:09:18 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)) 10:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:09:18 INFO - Running setup.py (path:/tmp/pip-AcMquP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:09:18 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)) 10:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:09:18 INFO - Running setup.py (path:/tmp/pip-fj07p5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:09:18 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)) 10:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:09:18 INFO - Running setup.py (path:/tmp/pip-HDmoaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:09:18 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)) 10:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:09:18 INFO - Running setup.py (path:/tmp/pip-rb5ic6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:09:18 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)) 10:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:09:18 INFO - Running setup.py (path:/tmp/pip-B9fe0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:09:18 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)) 10:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:09:18 INFO - Running setup.py (path:/tmp/pip-5C0cJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:09:18 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)) 10:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:09:18 INFO - Running setup.py (path:/tmp/pip-2ymmBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:09:19 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)) 10:09:19 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)) 10:09:19 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)) 10:09:19 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)) 10:09:19 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)) 10:09:19 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)) 10:09:19 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)) 10:09:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:20 INFO - Downloading blessings-1.6.tar.gz 10:09:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:09:20 INFO - Installing collected packages: blessings 10:09:20 INFO - Running setup.py install for blessings 10:09:20 INFO - Successfully installed blessings 10:09:20 INFO - Cleaning up... 10:09:20 INFO - Return code: 0 10:09:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:09:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:09:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:09:20 INFO - Reading from file tmpfile_stdout 10:09:20 INFO - Current package versions: 10:09:20 INFO - argparse == 1.2.1 10:09:20 INFO - blessings == 1.6 10:09:20 INFO - blobuploader == 1.2.4 10:09:20 INFO - docopt == 0.6.1 10:09:20 INFO - functools32 == 3.2.3-2 10:09:20 INFO - jsonschema == 2.5.1 10:09:20 INFO - manifestparser == 1.1 10:09:20 INFO - mozInstall == 1.13 10:09:20 INFO - mozcrash == 1.0 10:09:20 INFO - mozdebug == 0.1 10:09:20 INFO - mozdevice == 0.51 10:09:20 INFO - mozfile == 1.2 10:09:20 INFO - mozhttpd == 0.7 10:09:20 INFO - mozinfo == 0.10 10:09:20 INFO - mozleak == 0.1 10:09:20 INFO - mozlog == 3.5 10:09:20 INFO - moznetwork == 0.27 10:09:20 INFO - mozprocess == 0.25 10:09:20 INFO - mozprofile == 0.28 10:09:20 INFO - mozrunner == 6.13 10:09:20 INFO - mozscreenshot == 0.1 10:09:20 INFO - mozsystemmonitor == 0.3 10:09:20 INFO - moztest == 0.8 10:09:20 INFO - mozversion == 1.4 10:09:20 INFO - psutil == 3.1.1 10:09:20 INFO - requests == 1.2.3 10:09:20 INFO - wsgiref == 0.1.2 10:09:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:09:20 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')]} 10:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:20 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')]} 10:09:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:20 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 0x23a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2573a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2716d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2713eb0>, '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 0x2714db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2715240>, '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': 'fcadb68e09dcf59683000ff6000001dc-1500738863.498441-438096369', '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 10:09:20 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 10:09:20 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 10:09:20 INFO - Using env: {'DISPLAY': ':0', 10:09:20 INFO - 'HOME': '/home/cltbld', 10:09:20 INFO - 'LANG': 'en_US.UTF-8', 10:09:20 INFO - 'LANGUAGE': 'en_US:en', 10:09:20 INFO - 'LOGNAME': 'cltbld', 10:09:20 INFO - 'MAIL': '/var/mail/cltbld', 10:09:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:20 INFO - 'MOZ_NO_REMOTE': '1', 10:09:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:20 INFO - 'NO_EM_RESTART': '1', 10:09:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:20 INFO - 'PWD': '/builds/slave/test', 10:09:20 INFO - 'SHELL': '/bin/bash', 10:09:20 INFO - 'SHLVL': '1', 10:09:20 INFO - 'TERM': 'linux', 10:09:20 INFO - 'TMOUT': '86400', 10:09:20 INFO - 'USER': 'cltbld', 10:09:20 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1500738863.498441-438096369', 10:09:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:20 INFO - '_': '/tools/buildbot/bin/python'} 10:09:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:20 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)) 10:09:20 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)) 10:09:20 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)) 10:09:20 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)) 10:09:20 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)) 10:09:20 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)) 10:09:20 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)) 10:09:20 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)) 10:09:20 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)) 10:09:20 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:21 INFO - Downloading marionette_driver-1.4.0.tar.gz 10:09:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 10:09:21 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 10:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 10:09:22 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)) 10:09:22 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)) 10:09:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:09:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:09:22 INFO - Installing collected packages: marionette-driver, simplejson 10:09:22 INFO - Running setup.py install for marionette-driver 10:09:22 INFO - Running setup.py install for simplejson 10:09:22 INFO - building 'simplejson._speedups' extension 10:09:22 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 10:09:23 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 10:09:23 INFO - Successfully installed marionette-driver simplejson 10:09:23 INFO - Cleaning up... 10:09:23 INFO - Return code: 0 10:09:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:09:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:23 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 0x23a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2573a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2716d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2713eb0>, '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 0x2714db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2715240>, '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': 'fcadb68e09dcf59683000ff6000001dc-1500738863.498441-438096369', '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 10:09:23 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 10:09:23 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 10:09:23 INFO - Using env: {'DISPLAY': ':0', 10:09:23 INFO - 'HOME': '/home/cltbld', 10:09:23 INFO - 'LANG': 'en_US.UTF-8', 10:09:23 INFO - 'LANGUAGE': 'en_US:en', 10:09:23 INFO - 'LOGNAME': 'cltbld', 10:09:23 INFO - 'MAIL': '/var/mail/cltbld', 10:09:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:23 INFO - 'MOZ_NO_REMOTE': '1', 10:09:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:23 INFO - 'NO_EM_RESTART': '1', 10:09:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:23 INFO - 'PWD': '/builds/slave/test', 10:09:23 INFO - 'SHELL': '/bin/bash', 10:09:23 INFO - 'SHLVL': '1', 10:09:23 INFO - 'TERM': 'linux', 10:09:23 INFO - 'TMOUT': '86400', 10:09:23 INFO - 'USER': 'cltbld', 10:09:23 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1500738863.498441-438096369', 10:09:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:23 INFO - '_': '/tools/buildbot/bin/python'} 10:09:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:09:23 INFO - Cleaning up... 10:09:23 INFO - Return code: 0 10:09:23 INFO - Running post-action listener: _resource_record_post_action 10:09:23 INFO - Running post-action listener: _start_resource_monitoring 10:09:23 INFO - Starting resource monitoring. 10:09:23 INFO - [mozharness: 2017-07-22 17:09:23.618246Z] Finished create-virtualenv step (success) 10:09:23 INFO - [mozharness: 2017-07-22 17:09:23.618718Z] Running install step. 10:09:23 INFO - Running pre-action listener: _resource_record_pre_action 10:09:23 INFO - Running main action method: install 10:09:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:09:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:09:23 INFO - Reading from file tmpfile_stdout 10:09:23 INFO - Detecting whether we're running mozinstall >=1.0... 10:09:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:09:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:09:23 INFO - Reading from file tmpfile_stdout 10:09:23 INFO - Output received: 10:09:23 INFO - Usage: mozinstall [options] installer 10:09:23 INFO - Options: 10:09:23 INFO - -h, --help show this help message and exit 10:09:23 INFO - -d DEST, --destination=DEST 10:09:23 INFO - Directory to install application into. [default: 10:09:23 INFO - "/builds/slave/test"] 10:09:23 INFO - --app=APP Application being installed. [default: firefox] 10:09:23 INFO - mkdir: /builds/slave/test/build/application 10:09:23 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'] 10:09:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:09:41 INFO - Reading from file tmpfile_stdout 10:09:41 INFO - Output received: 10:09:42 INFO - /builds/slave/test/build/application/firefox/firefox 10:09:42 INFO - Running post-action listener: _resource_record_post_action 10:09:42 INFO - [mozharness: 2017-07-22 17:09:42.000515Z] Finished install step (success) 10:09:42 INFO - [mozharness: 2017-07-22 17:09:42.000663Z] Running setup-mitmproxy step. 10:09:42 INFO - Running pre-action listener: _resource_record_pre_action 10:09:42 INFO - Running main action method: setup_mitmproxy 10:09:42 INFO - Skipping: mitmproxy is not required 10:09:42 INFO - Running post-action listener: _resource_record_post_action 10:09:42 INFO - [mozharness: 2017-07-22 17:09:42.001196Z] Finished setup-mitmproxy step (success) 10:09:42 INFO - [mozharness: 2017-07-22 17:09:42.001299Z] Running run-tests step. 10:09:42 INFO - Running pre-action listener: _resource_record_pre_action 10:09:42 INFO - Running pre-action listener: _set_gcov_prefix 10:09:42 INFO - Running main action method: run_tests 10:09:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:09:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:09:42 INFO - Python 2.7.3 10:09:42 INFO - Return code: 0 10:09:42 INFO - grabbing minidump binary from tooltool 10:09:42 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')]} 10:09:42 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 0x2713eb0>, '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 0x2714db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2715240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:09:42 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 10:09:42 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 10:09:42 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 10:09:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:09:42 INFO - Return code: 0 10:09:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:09:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:09:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:09:42 INFO - ENV: RUST_BACKTRACE is now 1 10:09:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:09:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:09:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Pp1sd-lkQXyYNmBkPeE-0w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-075', '--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 10:09:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Pp1sd-lkQXyYNmBkPeE-0w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-075 --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 10:09:42 INFO - Using env: {'DISPLAY': ':0', 10:09:42 INFO - 'HOME': '/home/cltbld', 10:09:42 INFO - 'LANG': 'en_US.UTF-8', 10:09:42 INFO - 'LANGUAGE': 'en_US:en', 10:09:42 INFO - 'LOGNAME': 'cltbld', 10:09:42 INFO - 'MAIL': '/var/mail/cltbld', 10:09:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:09:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:42 INFO - 'MOZ_NO_REMOTE': '1', 10:09:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:09:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:42 INFO - 'NO_EM_RESTART': '1', 10:09:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:42 INFO - 'PWD': '/builds/slave/test', 10:09:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:09:42 INFO - 'RUST_BACKTRACE': '1', 10:09:42 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:09:42 INFO - 'SHELL': '/bin/bash', 10:09:42 INFO - 'SHLVL': '1', 10:09:42 INFO - 'TERM': 'linux', 10:09:42 INFO - 'TMOUT': '86400', 10:09:42 INFO - 'USER': 'cltbld', 10:09:42 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1500738863.498441-438096369', 10:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:42 INFO - '_': '/tools/buildbot/bin/python'} 10:09:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Pp1sd-lkQXyYNmBkPeE-0w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-075', '--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 10:09:42 INFO - mozversion application_buildid: 20170722162434 10:09:42 INFO - mozversion application_changeset: c22502562670e5e53bea543a3ee25c81f1a7b624 10:09:42 INFO - mozversion application_display_name: Nightly 10:09:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:09:42 INFO - mozversion application_name: Firefox 10:09:42 INFO - mozversion application_remotingname: firefox 10:09:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:09:42 INFO - mozversion application_vendor: Mozilla 10:09:42 INFO - mozversion application_version: 56.0a1 10:09:42 INFO - mozversion platform_buildid: 20170722162434 10:09:42 INFO - mozversion platform_changeset: c22502562670e5e53bea543a3ee25c81f1a7b624 10:09:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:09:42 INFO - mozversion platform_version: 56.0a1 10:09:42 INFO - using testdate: 1500743382 10:09:42 INFO - actual date: 1500743382 10:09:42 INFO - starting webserver on 'localhost:37329' 10:09:42 INFO - SUITE-START | Running 2 tests 10:09:42 INFO - TEST-START | dromaeo_css 10:09:42 INFO - Initialising browser for dromaeo_css test... 10:09:42 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37329/getInfo.html -profile /tmp/tmps0fOF_/profile 10:09:42 INFO - TEST-INFO | started process 3606 (/builds/slave/test/build/application/firefox/firefox http://localhost:37329/getInfo.html) 10:09:49 INFO - TEST-INFO | 3606: exit 0 10:09:49 INFO - Browser initialized. 10:09:49 INFO - Running cycle 1/1 for dromaeo_css test... 10:09:49 INFO - TEST-INFO | started process 3819 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps0fOF_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:10:00 INFO - PID 3819 | RSS: Main: 174170112 10:10:00 INFO - PID 3819 | 10:12:59 INFO - PID 3819 | Cycle 1(1): loaded http://localhost:37329/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37329/tests/dromaeo/cssquery-ext.html) 10:13:00 INFO - PID 3819 | RSS: Main: 179585024 10:13:00 INFO - PID 3819 | 10:16:02 INFO - PID 3819 | Cycle 1(1): loaded http://localhost:37329/tests/dromaeo/cssquery-ext.html (next: http://localhost:37329/tests/dromaeo/cssquery-jquery.html) 10:16:03 INFO - PID 3819 | RSS: Main: 177438720 10:16:03 INFO - PID 3819 | 10:19:04 INFO - PID 3819 | Cycle 1(1): loaded http://localhost:37329/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37329/tests/dromaeo/cssquery-mootools.html) 10:19:05 INFO - PID 3819 | RSS: Main: 178229248 10:19:05 INFO - PID 3819 | 10:22:07 INFO - PID 3819 | Cycle 1(1): loaded http://localhost:37329/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37329/tests/dromaeo/cssquery-prototype.html) 10:22:07 INFO - PID 3819 | RSS: Main: 177741824 10:22:07 INFO - PID 3819 | 10:25:11 INFO - PID 3819 | Cycle 1(1): loaded http://localhost:37329/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37329/tests/dromaeo/cssquery-yui.html) 10:25:12 INFO - PID 3819 | RSS: Main: 179171328 10:25:12 INFO - PID 3819 | 10:28:14 INFO - PID 3819 | Cycle 1(1): loaded http://localhost:37329/tests/dromaeo/cssquery-yui.html (next: http://localhost:37329/tests/dromaeo/cssquery-dojo.html) 10:28:14 INFO - PID 3819 | RSS: Main: 182104064 10:28:14 INFO - PID 3819 | 10:28:14 INFO - PID 3819 | __start_tp_report 10:28:14 INFO - PID 3819 | _x_x_mozilla_page_load 10:28:14 INFO - PID 3819 | _x_x_mozilla_page_load_details 10:28:14 INFO - PID 3819 | |i|pagename|runs| 10:28:14 INFO - PID 3819 | |0;dojo.html;3121.438141134595;3150.952735708964;3157.431662300786;3167.540706597542;3218.404595149896;6058.848528786777;6202.286737025243;6204.720787564559;6221.937780622198;6230.563860529759;6029.186059881915;6148.38516148386;6150.138980542716;6155.661438620874;6158.56890017699;5541.445855414467;5577.358603760558;5693.686847223401;5704.344000439961;5705.572082093839;5670.744816483248;5684.37471878093;5723.5135013523695;5736.139579063132;5770.163326317703;589.0915167479477;5572.275604171452;5587.357453892813;5694.288213973254;5697.6866272355;5607.971960140214;5619.381867994517;5694.715264236813;5698.116791897262;5705.800296989627;5567.331920169606;5571.721413929287;5671.659700417947;5675.120356344773;5686.601937864351;5993.850153746148;6063.333033366326;6175.814725558241;6180.103884936704;6217.720202590895;6450.774222902222;6600.570962887445;6633.4029937305395;6703.430208432289;6720.462363010947;6531.477481801445;6618.86762264752;6703.765368212138;6732.057511948331;6769.0861733665815;6107.4808641265545;6140.324564297879;6157.230346206724;6182.69086545671;6225.470834979077;6759.121314229119;6782.694778734969;6854.554453960476;6858.3827455529245;6884.931150688429;6382.106505089291;6388.361163883667;6491.123698300763;6521.576097553644;6524.314946930599;6626.204855417381;6672.733090676318;6679.499037572202;6680.23177334603;6718.361755633207;6551.705173267119;6616.933830661632;6667.233268174222;6670.299618540081;6674.933250667431;6482.546221764431;6523;6588.505862060365;6607.14107166075;6622.1722284714415;5307.65500242483;5322.733863306819;5327.147656375039;5344.625876188629;5359.678419294854;4549.044700612908;4595.494495605481;4603.332516785047;4611.446626404853;4628.352030715702;5654.9151762723595;5680.318361796611;5740.56945729072;5745.626534275342;5810.1865738796605;6644.036614690843;6654.068430419745;6693.598384096969;6712.228093769181;6721.66391680414;5716.256886604715;5752.194692743019;5827.650340979555;5835.824925252249;5840.094785308284;5736.139579063174;5777.62445441045;5787.855303617359;5819.301683797971;5845.532357411397;6399.424051835357;6496.512761542903;6529.2817790043055;6530.444912182423;6534.052562378429;6620.2386725527185;6621.735130594722;6693.1298931138645;6714.261431242462;6718.39534441883;6395.488360931021;6402.263739669811;6412.583182093149;6467.741290348334;6498.707558159988;6511.34886511345;6546.705398256994;6591.538592298493;6602.20773507163;6625.304343043911;6640.900386494303;6649.202095748541;6657.500687448364;6738.831529211613;6742.460603151834;6372.522060845363;6419.550631455753;6437.806865794034;6470.28826829039;6527.379898909596;6470.773522926675;6477.611343319416;6479.060536222316;6494.577852439576;6527.771527996498;6368.649724265025;6456.709448074754;6462;6465.385788350287;6465.612063276219;6400.55196136266;6484.286728459771;6488.643124628191;6579.374959378852;6595.142631457879;6191.535634827316;6284.24589049317;6296.6851657417865;6308.116863639002;6385.946318857336 10:28:14 INFO - PID 3819 | |1;ext.html;797.5932274539987;824.6948629007267;842.70926530347;845.0113367360188;1157.4733496259203;30847.537286940686;32488.67511324889;42991.140177196474;43384.56615433845;43614.12771744563;43951.78024109883;43958;44431.77784111083;44433.77783111088;44520.77739611305;7716.035495563068;7862.410319226081;7871.685132594718;7872.488288261245;7906.486078404914;7803.18066603007;7920.9207907921045;7926.445148839583;7927.682892684285;7972.521648701097;7949.244821741925;7975.162607926171;7987.241212084843;7995.400344974121;7997.440179187459;7900.367970562341;7903.841923161504;7910.604469776517;7936.087349954742;7955.681772729084;7786.805329866742;7863;7863.56750378729;7864.2922137007945;7868.842623147505;40107;40393.39409908854;40399.39400908989;40430.79784601058;40468.190636187406;3555.928881422357;3608.0438683748825;3611.331903597843;3616.6021737608844;3618.4029635110173;31869;31935.361292774014;31941.680583194102;31946.361072778647;32047.83976080128;4750.239961606161;4907.092187945206;4942.654014219006;4958.3306253655655;4979.7261150636705;188741;189086;189753;190034.9999999986;190109;49402.50597494051;49411;49459.75270123698;51719.22421163686;53096.73451632717;54828.451715483134;54863.17705234425;54957;54991.45008549863;55030.44969550333;16033.518994430186;16247.593810154603;16369.590760231089;16371.099589522453;16383.918080409521;12795.23228606268;12804.423800928795;12806.359682015862;12814.67963300925;13126.212427254395;14930.477433289783;14936.626584335478;14974.251287435802;15111.54665360041;15190.392384304725;5762.366139724627;5870.882582348329;5922.644641321448;5953.940460595339;5971.4327138921735;997.9750506237402;1004.1314263162458;1016.8576399304103;1041.0890470838017;1051.3113910388709;22997.540049198924;23071.53856922852;23679.526409471713;28682.282942926176;29271.511921486486;1087.9891201088046;1113.2652449383368;1118.703543560957;1119.4123085380077;1124.8650161980615;12642.810357844639;12666.176698514568;12807.61577152687;12868.163569367962;12922.483100675867;228796;230120;230230;234030;237049;58452.12321815176;59247;59583;59639.40360596425;59653.40346596565;1495.349522957517;1507.8341382447923;1509.4716849102726;1518.916459594733;1525.7406240939067;26762.732372676022;27789.861050694617;27998.86000569984;28065.859670701517;28140.71859281381;51972.74013629908;53212.201816972;53268.4673153279;53424;53443.198352023974;209518;209646;210916;211246;211969;38486.42270365891;38517.6148238514;38718.61281387263;39062;39064.41403379008;46939.76530117328;47011.52988470208;47067.529324707684;47248.2912756302;47259;30959;35156.296874062886;35476.113097172776;36393.45409818802;36521.45217821788;35079;35299;35689.46465802963;35701.64298356983;36030.8198459006;38002.42996355112;39873.60126398699;39936.60063399445;39963.2007359857;40053.19893602053;33644.83177584096;34688.306233875686;35131.29737405289;35287.47068793919;35415.468767967985;23414.88292558526;24567.262982110566;24653.876730616234;25615.743842561336;26484.073057442896 10:28:14 INFO - PID 3819 | |2;jquery.html;566.7959534567555;579.7912751409489;583.2767368463102;584.2054805464568;606.5632744424015;22294.88852555737;22952.88523557384;23202;23210.535789284226;23227.187048453306;21880.12479500818;22104.447388815286;22253.66619500709;22262.666060009113;22550.21074262401;6496.480281577463;6660.966695166518;6668.399844014038;6675.699593518303;6677.666116694146;6273.278572964099;6542.738290468375;6563.245226798931;6583.407493325623;6610.933890661104;6536.54244202906;6536.836579085513;6538.6076835389795;6549.836254093662;6551.1483507144;6557.836054098638;6558.540902136876;6560.868782624369;6564.245111812155;6569.737210511574;6100.847478813021;6105.908411373788;6112.877742445171;6116.4800991915745;6137.386261373871;28327.15018549447;28953.85523072371;29243.415131697246;29865.850670746724;30390.54414183789;1823.881447705895;1877.2678655324298;1882.407041781848;1882.4540883143873;1886.8490520758307;18683.15925783343;19374.612507749905;19377.4186774397;19451.221951121937;19488.317908873265;2205.63607004844;2290.8854557272234;2305.273838740808;2335.859848409101;2352.5882970480097;130985;133548;134609.32695336558;134612;135058;14452.349644266033;15408.537743867702;15440.768388474182;15510.922445387701;16039.358425663077;23545.29364119079;23577.646335304984;23598.528029439316;23631.645525317133;23643.881780590986;10140.138088262433;10170.694879153638;10270.178385729123;10297.17622590191;10452.73868153287;7350.485466017434;9486.383385080086;9527.857082143773;9661.13049825505;9663.855042174373;8109.878351824727;9197.034311397341;9222;9365.765855853659;9472.57373418184;2777.125205560242;2778.2776478115834;2780.902668406596;2874.6262985812127;2876.6548014238424;903.9361516204807;907.6006557114848;950.8193443245762;963.720521048902;965.3001573859036;18796.906015469835;19265.325713599956;19563.413097607096;19763.703544446846;20108.39674809758;987.8863930647924;997.7677568203408;1008.5713571731984;1023.155896385485;1040.6721882606955;9920.4543750093;12969.35153242353;13800.17198968045;14091.577252682437;14156.221407822462;483544;484699;502032;504428;505013;117967.41016295036;119174;120274;121142.39428802975;123769.38115309365;1251.5807204586383;1252.511520507003;1290.6832236136158;1292.4377895615437;1296.3647812571771;20425.85528519484;20579.58840823145;20707.378778636667;21411;21498.355049348545;56845.43154568567;56866.43133568612;58618.4138158613;58794;59576;70801.93797093151;71495;71752.64123679348;71759.64120179365;72057.63971180111;12434.440450179945;12923.612291631267;14196.92901535527;14458.277086145441;14880.255987200813;22527.549449011254;22929.770702292764;22979.540409192057;23073.423164421023;23170;17321.653566928842;18201.726974095134;19296.517587060436;19336;19378.03109844474;16289.18554072268;16494.570976534407;17410.39063632767;17454.127293635014;17872.55318617045;19089.522761931064;19907.203711851365;20073.397798066082;20107.899460502606;20131.899340503205;14822.40710371573;15026;15043.699126017636;15050.172240526876;15073.924630376778;17432.73850892263;18200.089995499908;18267.269309227482;18405.355812546495;18424.35514756977 10:28:14 INFO - PID 3819 | |3;mootools.html;1366.6173471428;1368.8631136886313;1378.5657517881873;1390.9721805563888;1415;13517.662058448532;14177.07848989815;14260.073095248814;14260.215688137148;14262.429502819889;13424.060315777899;13857.93071034646;14447.638809029779;14509.274536273197;14516.854831451683;2587.573050446674;2660.1620489545826;2662.2146466792246;2668.4262883480046;2672.4521473097966;2585.6897172339345;2597.2467984284535;2645.7354264573487;2690.515707172708;2691.058129654615;2609.712931577525;2613.7516935891153;2633.802464815137;2639.1290874011625;2640.471905618874;2548.630448584954;2595.5976823592373;2610.5040042391884;2610.843349399042;2612.542805009116;2533.1134103063964;2548.643189953408;2555.872206389673;2591.08016654087;2606.569915963864;13540.187588744708;13834.377453014638;13842.546532614131;13844.446222151102;13856.792148117785;6975.755848545276;7235.529690570096;7235.746748863765;7236.746713865042;7241.746538871167;4876;5058.696478211319;5107;5113.437521872591;5173.8189163379475;1812.1754601656214;1847.8798878072882;1854.1378259109445;1896.0519740129935;1902.2391043582538;22469.325920222254;22913.65629515542;23034.53930921389;23052.884735576215;23068;6700.83247918806;6866.622335771581;7072.469564782662;7076.964615176891;7127.358537731629;15385.923070384577;15464.768028479582;15465.14941678196;15528.14595197275;15528.5341439757;6797.28628494001;7277.818054548678;7318.268173182639;7385.852282954311;7408.7036518539735;6781.6609169541325;6844.657767111724;6864.416524595365;6868.965655171693;6955.02629631852;4584.404027476474;5156.1750119980625;5257.369115706063;5266.578673706094;5274.630775845654;1259.6221133659865;1470.4265336518765;1497.7154340675236;1498.0637101811367;1507.9396824127132;868.1665601023088;882.2192359761657;888.1473785166313;914.9085091490931;920.604140219712;8480.915190848136;8525.19010693983;8544.273736732448;8746.475211487332;8823.426477278956;912.762681702762;932.6083045121065;992.1021475564626;993.101243374747;1009.2178561614808;4837.080954618611;5244.239585260192;5336.553093614176;5384.246205531229;5389.056915039931;18441.446756597325;19149.712754308697;19443.02784860751;19529.218831246875;19576.021198939998;18355.724664130048;18917.33789317395;19108.808911910703;19271.22915083381;19337.613247734967;10554.155667546578;10757.731056723487;10857.185711071543;10876.945615271872;10895.291806032583;7157.212706602374;7949.284564389232;8013.358931285366;8067.3142782864115;8133.389995750461;16215.67568648644;16501.669966600362;16807.66384672324;17065.232064557375;17076.316947321968;16412.425565105164;16729.079900605582;16835.074070925726;17133.858267716536;17198.398056067977;9104.726858194264;9317.673881414117;9319;9341.392809467363;9354.391964522285;11653.184277100521;12114.697132571404;12547.93726031364;12975.935120324339;13108.737825243632;10046.69859904204;10478.37129772216;10745.355278683304;10781.137508999418;10838.783224335311;10116.89883101189;10528.315659482416;10531.21015923824;10719.785604287714;10885.129189664649;9547.570359333708;9642;9651.469169195481;9652.083052110038;9661.613535458502;6335.588186767845;6567.441767449629;6675.566088204251;6856.242332359214;6970.616616086164;6727.394534491919;7009;7064.258252883374;7080.4335653148655;7149.606771627402 10:28:14 INFO - PID 3819 | |4;prototype.html;496.79813601339384;502.64061196244677;515.7962604771118;523.0767695018292;527.7176710459902;6043.220118745371;6068.848278793027;6074.149619053336;6116.602420842648;6142.341567776709;5870.060790273557;5977.402259774031;6035.637861728299;6037.637741735499;6055;4805.279208118775;4885.291632713254;4888.951110488885;4899.167141585921;4937.358143441347;4797.928031079537;4912.21404575268;4920.97539512302;4935.802567897298;4948.703077815325;4787.066522028206;4832.516748325174;4863.440704319013;4864.221724524077;4883.243097319921;4863.708177509361;4871.951280487203;4885.511448855122;4934.185859333205;4992.45083040867;4429.534898835608;4430.224710675619;4454.33185022246;4454.510003899569;4459.662101369576;5951.797834801108;5977.3723759005115;5997.4510832896285;5997.6701281429505;6010.2186715726675;5559.694216818073;5562.805301814417;5587.161925711135;5602.187682786014;5672.40439753824;6314.5895516791725;6435.710393032325;6435.935640643581;6451.322656109399;6458.870822583522;4802.27965805132;4837.1776797944085;4839.806407743686;4865.489123642037;4870.512948705101;6774.525783195129;6793.218779840283;6806.421454176401;6812.727490900358;6840.760573379957;4920.114379411741;4947.703137811743;4957.231629097496;4974.253861920741;4986.152354099811;4989.301497790312;5033.47148549397;5037.899242015213;5040.798368065236;5064.720875605992;5609.86569474264;5623.156526521055;5647.407022262685;5661.66030038199;5674.914876276859;6033.728482218311;6450.935490645127;6478.352164783484;6503.577267477599;6506.219253689587;1651.9504414867574;1712.734526148449;1731.6796392667397;1739.3390511605762;1742.668892910343;1191.8212268159673;1209.195884736658;1217.829503869459;1227.5212667059855;1229.9668278645981;5643.379228284885;5685.144301369513;5707;5726.455986681259;5727.140928860705;6430.7106180222;6496.837579060467;6561.1470508833545;6564.86870262592;6686.13080299558;5638.633488823213;5651.802186923438;5672.97163514188;5682.715864206773;5716.342620598684;3524.242287908112;3546.804925729058;3558.1638314995957;3561.30554541867;3562.3460521910824;6468.417842394113;6470.935290647128;6506.544541882023;6510.7721229756735;6520.804375868732;6667.733290668319;6753.729850805913;6815.318468153145;6850.417714494224;6871.587704737732;6247.250329960434;6323.146375239284;6370.74517019314;6375.171227740364;6416.550841441054;6539.757446085228;6630.801075967729;6633.734650613921;6634.469242460688;6637.933620663732;6477.255115661759;6535.673216339259;6536.705848236746;6575.704093315717;6605.702743376463;6380.321513852768;6413.262474815456;6426.943378118957;6456.354364563506;6458.806235812933;5358.276632654542;5379.67721936685;5430.375506816767;5467.605760531039;5475.4250803665045;6310.52671049664;6510.707018184098;6592.978088396306;6624.9337506624315;6676.499262555425;6204.162438070803;6407.263164736115;6411.185344719885;6434.517411194086;6462.547621666438;6395.232572091379;6412.551121421642;6449.484041276781;6460.547761656827;6489.221293444817;6126.938730612636;6299.496040316855;6301.527385446018;6301.779437719842;6403.327650596807;6394.712237949397;6415.743370265323;6421.743130274736;6423.164988551645;6526.184226971629;6177.444030037318;6200.395833749746;6223.844403889939;6310.810675679737;6328.588641738273 10:28:14 INFO - PID 3819 | |5;yui.html;872.6727477196048;889.2441424788926;890.9821803563925;903.93672442929;914.2594498456251;18181.7272740909;19223;19229.615407691854;19237.326693565727;21509.569808603857;20984.790152098474;21604.89197554014;21756.8912155439;21923.342299730994;21924;1002.3584905660365;1031.9896801031969;1033.5504055735742;1036.3678156324636;1038.226521241676;1019.1235537437798;1032.5353590884095;1058.1693370704;1080.5137688040375;1086.353619596343;1127.2053202492223;1132.4451019000671;1135.125953016177;1139.692283083571;1140.5095808802212;1113.2708076210095;1115.046635126971;1118.1893127482551;1120.63019203663;1120.9159313051555;816.4285000499674;816.5264146794844;816.6570040582969;818.1613845808035;818.6193420059641;18281.360152394736;18282;18283.360082397186;18655.347062852736;19834.60330793376;19964.3012494562;20795.5840883183;21193.470163246042;21241.04415301315;21253.468663283387;15516.991540456454;15553.766693499607;15766.290516926765;15796.05223686571;15854.920725396414;3552.626974167701;3608.548931383577;3617.5297211362354;3619.7647152934974;3620.0406892173596;124392.37803811014;126255.36872315672;126934.36532817369;127101.99999999907;129245.35377323053;16330.836691632932;16681.416150434678;16717.164141793106;16819;16823.242954067096;30304.242393939887;30958.69041309558;31084.533731994037;31134.37731245408;31157.376852462825;8576.313894888393;8576.485410875368;8586.39895207342;8629.22336989674;8663.653453861774;3928.273269445162;3961.1285517186175;3964.6035396460125;3988.222296652183;3991.341428664296;5072.289879416885;5719.7140142992685;5921.970390148022;5929.644221346733;5976.342602313742;1082.0640146273417;1117.1565468071553;1122.1079242002627;1130.8416821644976;1136.9602063927723;666.8132922781532;685.7325642999234;690.8687349403698;691.5366704308126;699.433458898294;11725.824112638316;11782.94108529469;12147.210431321935;12269.607426551915;12379.93810030962;672.1530871102349;673.1282988529865;681.4105798484276;684.7466437418087;689.4105539763531;5898.498627616701;6033.9698301508215;6042.063480160494;6057.969710151421;6453.096566480603;101398;103488.48255758673;103740.48129759303;104120;105101.47449262705;82377.58811205905;83086.58456707677;87189.56405217934;89617;92926;73907.26092739111;77602;79088;79624;80163;11942.402879856147;12239.20445171061;12316.568920087753;12365.567205147776;12544.560940367044;36315.55266710015;37039.21911276474;37597.62402375941;38098.42852357272;38112;67402.32597674157;67414;68758;69272;73865.63067184844;17843.37548185807;18314.26742930268;18667.90666046661;19442.90278548598;19955.700664490334;20376;21079.8946005269;21110.57778844445;21353.25263615766;21750.12999480003;17806.732899006267;18556.536086597403;18632.813671863107;18870.433886983414;19057.428277151706;18699.25202991865;18930.053497325353;19258.133383997472;19296.8070319295;19340.22639094477;17628;18525.53686157857;18542.907285463487;18756.155972980974;18771.90614046921;12902.290374029519;13381.063325567116;13473.730525389241;13969.742723154965;14736.410543578137;13264.403101860247;13480.73038539204;13884.305784710523;14304;14445.855541444871 10:28:14 INFO - PID 3819 | __end_tp_report 10:28:14 INFO - PID 3819 | __start_cc_report 10:28:14 INFO - PID 3819 | _x_x_mozilla_cycle_collect,373 10:28:14 INFO - PID 3819 | __end_cc_report 10:28:14 INFO - PID 3819 | __startTimestamp1500744494300__endTimestamp 10:28:14 INFO - PID 3819 | 10:28:14 INFO - PID 3819 | ------- Summary: start ------- 10:28:14 INFO - PID 3819 | Number of tests: 6 10:28:14 INFO - PID 3819 | 10:28:14 INFO - PID 3819 | [#0] dojo.html Cycles:165 Average:6075.48 Median:6385.95 stddev:838.96 (13.1%) stddev-sans-first:808.89 10:28:14 INFO - PID 3819 | Values: 3121.4 3151.0 3157.4 3167.5 3218.4 6058.8 6202.3 6204.7 6221.9 6230.6 6029.2 6148.4 6150.1 6155.7 6158.6 5541.4 5577.4 5693.7 5704.3 5705.6 5670.7 5684.4 5723.5 5736.1 5770.2 589.1 5572.3 5587.4 5694.3 5697.7 5608.0 5619.4 5694.7 5698.1 5705.8 5567.3 5571.7 5671.7 5675.1 5686.6 5993.9 6063.3 6175.8 6180.1 6217.7 6450.8 6600.6 6633.4 6703.4 6720.5 6531.5 6618.9 6703.8 6732.1 6769.1 6107.5 6140.3 6157.2 6182.7 6225.5 6759.1 6782.7 6854.6 6858.4 6884.9 6382.1 6388.4 6491.1 6521.6 6524.3 6626.2 6672.7 6679.5 6680.2 6718.4 6551.7 6616.9 6667.2 6670.3 6674.9 6482.5 6523.0 6588.5 6607.1 6622.2 5307.7 5322.7 5327.1 5344.6 5359.7 4549.0 4595.5 4603.3 4611.4 4628.4 5654.9 5680.3 5740.6 5745.6 5810.2 6644.0 6654.1 6693.6 6712.2 6721.7 5716.3 5752.2 5827.7 5835.8 5840.1 5736.1 5777.6 5787.9 5819.3 5845.5 6399.4 6496.5 6529.3 6530.4 6534.1 6620.2 6621.7 6693.1 6714.3 6718.4 6395.5 6402.3 6412.6 6467.7 6498.7 6511.3 6546.7 6591.5 6602.2 6625.3 6640.9 6649.2 6657.5 6738.8 6742.5 6372.5 6419.6 6437.8 6470.3 6527.4 6470.8 6477.6 6479.1 6494.6 6527.8 6368.6 6456.7 6462.0 6465.4 6465.6 6400.6 6484.3 6488.6 6579.4 6595.1 6191.5 6284.2 6296.7 6308.1 6385.9 10:28:14 INFO - PID 3819 | 10:28:14 INFO - PID 3819 | [#1] ext.html Cycles:180 Average:39716.70 Median:36457.45 stddev:54843.23 (150.4%) stddev-sans-first:54919.22 10:28:14 INFO - PID 3819 | Values: 797.6 824.7 842.7 845.0 1157.5 30847.5 32488.7 42991.1 43384.6 43614.1 43951.8 43958.0 44431.8 44433.8 44520.8 7716.0 7862.4 7871.7 7872.5 7906.5 7803.2 7920.9 7926.4 7927.7 7972.5 7949.2 7975.2 7987.2 7995.4 7997.4 7900.4 7903.8 7910.6 7936.1 7955.7 7786.8 7863.0 7863.6 7864.3 7868.8 40107.0 40393.4 40399.4 40430.8 40468.2 3555.9 3608.0 3611.3 3616.6 3618.4 31869.0 31935.4 31941.7 31946.4 32047.8 4750.2 4907.1 4942.7 4958.3 4979.7 188741.0 189086.0 189753.0 190035.0 190109.0 49402.5 49411.0 49459.8 51719.2 53096.7 54828.5 54863.2 54957.0 54991.5 55030.4 16033.5 16247.6 16369.6 16371.1 16383.9 12795.2 12804.4 12806.4 12814.7 13126.2 14930.5 14936.6 14974.3 15111.5 15190.4 5762.4 5870.9 5922.6 5953.9 5971.4 998.0 1004.1 1016.9 1041.1 1051.3 22997.5 23071.5 23679.5 28682.3 29271.5 1088.0 1113.3 1118.7 1119.4 1124.9 12642.8 12666.2 12807.6 12868.2 12922.5 228796.0 230120.0 230230.0 234030.0 237049.0 58452.1 59247.0 59583.0 59639.4 59653.4 1495.3 1507.8 1509.5 1518.9 1525.7 26762.7 27789.9 27998.9 28065.9 28140.7 51972.7 53212.2 53268.5 53424.0 53443.2 209518.0 209646.0 210916.0 211246.0 211969.0 38486.4 38517.6 38718.6 39062.0 39064.4 46939.8 47011.5 47067.5 47248.3 47259.0 30959.0 35156.3 35476.1 36393.5 36521.5 35079.0 35299.0 35689.5 35701.6 36030.8 38002.4 39873.6 39936.6 39963.2 40053.2 33644.8 34688.3 35131.3 35287.5 35415.5 23414.9 24567.3 24653.9 25615.7 26484.1 10:28:14 INFO - PID 3819 | 10:28:14 INFO - PID 3819 | [#2] jquery.html Cycles:180 Average:35090.73 Median:12610.33 stddev:83480.57 (662.0%) stddev-sans-first:83674.52 10:28:14 INFO - PID 3819 | Values: 566.8 579.8 583.3 584.2 606.6 22294.9 22952.9 23202.0 23210.5 23227.2 21880.1 22104.4 22253.7 22262.7 22550.2 6496.5 6661.0 6668.4 6675.7 6677.7 6273.3 6542.7 6563.2 6583.4 6610.9 6536.5 6536.8 6538.6 6549.8 6551.1 6557.8 6558.5 6560.9 6564.2 6569.7 6100.8 6105.9 6112.9 6116.5 6137.4 28327.2 28953.9 29243.4 29865.9 30390.5 1823.9 1877.3 1882.4 1882.5 1886.8 18683.2 19374.6 19377.4 19451.2 19488.3 2205.6 2290.9 2305.3 2335.9 2352.6 130985.0 133548.0 134609.3 134612.0 135058.0 14452.3 15408.5 15440.8 15510.9 16039.4 23545.3 23577.6 23598.5 23631.6 23643.9 10140.1 10170.7 10270.2 10297.2 10452.7 7350.5 9486.4 9527.9 9661.1 9663.9 8109.9 9197.0 9222.0 9365.8 9472.6 2777.1 2778.3 2780.9 2874.6 2876.7 903.9 907.6 950.8 963.7 965.3 18796.9 19265.3 19563.4 19763.7 20108.4 987.9 997.8 1008.6 1023.2 1040.7 9920.5 12969.4 13800.2 14091.6 14156.2 483544.0 484699.0 502032.0 504428.0 505013.0 117967.4 119174.0 120274.0 121142.4 123769.4 1251.6 1252.5 1290.7 1292.4 1296.4 20425.9 20579.6 20707.4 21411.0 21498.4 56845.4 56866.4 58618.4 58794.0 59576.0 70801.9 71495.0 71752.6 71759.6 72057.6 12434.4 12923.6 14196.9 14458.3 14880.3 22527.5 22929.8 22979.5 23073.4 23170.0 17321.7 18201.7 19296.5 19336.0 19378.0 16289.2 16494.6 17410.4 17454.1 17872.6 19089.5 19907.2 20073.4 20107.9 20131.9 14822.4 15026.0 15043.7 15050.2 15073.9 17432.7 18200.1 18267.3 18405.4 18424.4 10:28:14 INFO - PID 3819 | 10:28:14 INFO - PID 3819 | [#3] mootools.html Cycles:180 Average:8584.30 Median:2608.14 stddev:5846.65 (224.2%) stddev-sans-first:5837.90 10:28:14 INFO - PID 3819 | Values: 1366.6 1368.9 1378.6 1391.0 1415.0 13517.7 14177.1 14260.1 14260.2 14262.4 13424.1 13857.9 14447.6 14509.3 14516.9 2587.6 2660.2 2662.2 2668.4 2672.5 2585.7 2597.2 2645.7 2690.5 2691.1 2609.7 2613.8 2633.8 2639.1 2640.5 2548.6 2595.6 2610.5 2610.8 2612.5 2533.1 2548.6 2555.9 2591.1 2606.6 13540.2 13834.4 13842.5 13844.4 13856.8 6975.8 7235.5 7235.7 7236.7 7241.7 4876.0 5058.7 5107.0 5113.4 5173.8 1812.2 1847.9 1854.1 1896.1 1902.2 22469.3 22913.7 23034.5 23052.9 23068.0 6700.8 6866.6 7072.5 7077.0 7127.4 15385.9 15464.8 15465.1 15528.1 15528.5 6797.3 7277.8 7318.3 7385.9 7408.7 6781.7 6844.7 6864.4 6869.0 6955.0 4584.4 5156.2 5257.4 5266.6 5274.6 1259.6 1470.4 1497.7 1498.1 1507.9 868.2 882.2 888.1 914.9 920.6 8480.9 8525.2 8544.3 8746.5 8823.4 912.8 932.6 992.1 993.1 1009.2 4837.1 5244.2 5336.6 5384.2 5389.1 18441.4 19149.7 19443.0 19529.2 19576.0 18355.7 18917.3 19108.8 19271.2 19337.6 10554.2 10757.7 10857.2 10876.9 10895.3 7157.2 7949.3 8013.4 8067.3 8133.4 16215.7 16501.7 16807.7 17065.2 17076.3 16412.4 16729.1 16835.1 17133.9 17198.4 9104.7 9317.7 9319.0 9341.4 9354.4 11653.2 12114.7 12547.9 12975.9 13108.7 10046.7 10478.4 10745.4 10781.1 10838.8 10116.9 10528.3 10531.2 10719.8 10885.1 9547.6 9642.0 9651.5 9652.1 9661.6 6335.6 6567.4 6675.6 6856.2 6970.6 6727.4 7009.0 7064.3 7080.4 7149.6 10:28:14 INFO - PID 3819 | 10:28:14 INFO - PID 3819 | [#4] prototype.html Cycles:180 Average:5434.70 Median:6003.94 stddev:1510.22 (25.2%) stddev-sans-first:1468.28 10:28:14 INFO - PID 3819 | Values: 496.8 502.6 515.8 523.1 527.7 6043.2 6068.8 6074.1 6116.6 6142.3 5870.1 5977.4 6035.6 6037.6 6055.0 4805.3 4885.3 4889.0 4899.2 4937.4 4797.9 4912.2 4921.0 4935.8 4948.7 4787.1 4832.5 4863.4 4864.2 4883.2 4863.7 4872.0 4885.5 4934.2 4992.5 4429.5 4430.2 4454.3 4454.5 4459.7 5951.8 5977.4 5997.5 5997.7 6010.2 5559.7 5562.8 5587.2 5602.2 5672.4 6314.6 6435.7 6435.9 6451.3 6458.9 4802.3 4837.2 4839.8 4865.5 4870.5 6774.5 6793.2 6806.4 6812.7 6840.8 4920.1 4947.7 4957.2 4974.3 4986.2 4989.3 5033.5 5037.9 5040.8 5064.7 5609.9 5623.2 5647.4 5661.7 5674.9 6033.7 6450.9 6478.4 6503.6 6506.2 1652.0 1712.7 1731.7 1739.3 1742.7 1191.8 1209.2 1217.8 1227.5 1230.0 5643.4 5685.1 5707.0 5726.5 5727.1 6430.7 6496.8 6561.1 6564.9 6686.1 5638.6 5651.8 5673.0 5682.7 5716.3 3524.2 3546.8 3558.2 3561.3 3562.3 6468.4 6470.9 6506.5 6510.8 6520.8 6667.7 6753.7 6815.3 6850.4 6871.6 6247.3 6323.1 6370.7 6375.2 6416.6 6539.8 6630.8 6633.7 6634.5 6637.9 6477.3 6535.7 6536.7 6575.7 6605.7 6380.3 6413.3 6426.9 6456.4 6458.8 5358.3 5379.7 5430.4 5467.6 5475.4 6310.5 6510.7 6593.0 6624.9 6676.5 6204.2 6407.3 6411.2 6434.5 6462.5 6395.2 6412.6 6449.5 6460.5 6489.2 6126.9 6299.5 6301.5 6301.8 6403.3 6394.7 6415.7 6421.7 6423.2 6526.2 6177.4 6200.4 6223.8 6310.8 6328.6 10:28:14 INFO - PID 3819 | 10:28:14 INFO - PID 3819 | [#5] yui.html Cycles:180 Average:23077.05 Median:19391.56 stddev:30530.28 (157.4%) stddev-sans-first:30570.40 10:28:14 INFO - PID 3819 | Values: 872.7 889.2 891.0 903.9 914.3 18181.7 19223.0 19229.6 19237.3 21509.6 20984.8 21604.9 21756.9 21923.3 21924.0 1002.4 1032.0 1033.6 1036.4 1038.2 1019.1 1032.5 1058.2 1080.5 1086.4 1127.2 1132.4 1135.1 1139.7 1140.5 1113.3 1115.0 1118.2 1120.6 1120.9 816.4 816.5 816.7 818.2 818.6 18281.4 18282.0 18283.4 18655.3 19834.6 19964.3 20795.6 21193.5 21241.0 21253.5 15517.0 15553.8 15766.3 15796.1 15854.9 3552.6 3608.5 3617.5 3619.8 3620.0 124392.4 126255.4 126934.4 127102.0 129245.4 16330.8 16681.4 16717.2 16819.0 16823.2 30304.2 30958.7 31084.5 31134.4 31157.4 8576.3 8576.5 8586.4 8629.2 8663.7 3928.3 3961.1 3964.6 3988.2 3991.3 5072.3 5719.7 5922.0 5929.6 5976.3 1082.1 1117.2 1122.1 1130.8 1137.0 666.8 685.7 690.9 691.5 699.4 11725.8 11782.9 12147.2 12269.6 12379.9 672.2 673.1 681.4 684.7 689.4 5898.5 6034.0 6042.1 6058.0 6453.1 101398.0 103488.5 103740.5 104120.0 105101.5 82377.6 83086.6 87189.6 89617.0 92926.0 73907.3 77602.0 79088.0 79624.0 80163.0 11942.4 12239.2 12316.6 12365.6 12544.6 36315.6 37039.2 37597.6 38098.4 38112.0 67402.3 67414.0 68758.0 69272.0 73865.6 17843.4 18314.3 18667.9 19442.9 19955.7 20376.0 21079.9 21110.6 21353.3 21750.1 17806.7 18556.5 18632.8 18870.4 19057.4 18699.3 18930.1 19258.1 19296.8 19340.2 17628.0 18525.5 18542.9 18756.2 18771.9 12902.3 13381.1 13473.7 13969.7 14736.4 13264.4 13480.7 13884.3 14304.0 14445.9 10:28:14 INFO - PID 3819 | -------- Summary: end -------- 10:28:14 INFO - PID 3819 | 10:28:15 INFO - TEST-INFO | 3819: exit 0 10:28:15 INFO - TEST-OK | dromaeo_css | took 1112732ms 10:28:15 INFO - TEST-START | kraken 10:28:15 INFO - Initialising browser for kraken test... 10:28:15 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37329/getInfo.html -profile /tmp/tmpUkZf8C/profile 10:28:15 INFO - TEST-INFO | started process 4176 (/builds/slave/test/build/application/firefox/firefox http://localhost:37329/getInfo.html) 10:28:21 INFO - TEST-INFO | 4176: exit 0 10:28:21 INFO - Browser initialized. 10:28:21 INFO - Running cycle 1/1 for kraken test... 10:28:21 INFO - TEST-INFO | started process 4394 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUkZf8C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:28:33 INFO - PID 4394 | RSS: Main: 174698496 10:28:33 INFO - PID 4394 | 10:28:35 INFO - PID 4394 | Cycle 1(1): loaded http://localhost:37329/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37329/tests/kraken/driver.html?testName=audio-beat-detection) 10:28:36 INFO - PID 4394 | RSS: Main: 180219904 10:28:36 INFO - PID 4394 | 10:28:39 INFO - PID 4394 | Cycle 1(1): loaded http://localhost:37329/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37329/tests/kraken/driver.html?testName=audio-dft) 10:28:40 INFO - PID 4394 | RSS: Main: 180527104 10:28:40 INFO - PID 4394 | 10:28:43 INFO - PID 4394 | Cycle 1(1): loaded http://localhost:37329/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37329/tests/kraken/driver.html?testName=audio-fft) 10:28:43 INFO - PID 4394 | RSS: Main: 173412352 10:28:43 INFO - PID 4394 | 10:28:45 INFO - PID 4394 | Cycle 1(1): loaded http://localhost:37329/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37329/tests/kraken/driver.html?testName=audio-oscillator) 10:28:46 INFO - PID 4394 | RSS: Main: 174534656 10:28:46 INFO - PID 4394 | 10:28:48 INFO - PID 4394 | Cycle 1(1): loaded http://localhost:37329/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37329/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:28:49 INFO - PID 4394 | RSS: Main: 174850048 10:28:49 INFO - PID 4394 | 10:28:52 INFO - PID 4394 | Cycle 1(1): loaded http://localhost:37329/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37329/tests/kraken/driver.html?testName=imaging-darkroom) 10:28:53 INFO - PID 4394 | RSS: Main: 177319936 10:28:53 INFO - PID 4394 | 10:28:56 INFO - PID 4394 | Cycle 1(1): loaded http://localhost:37329/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37329/tests/kraken/driver.html?testName=imaging-desaturate) 10:28:57 INFO - PID 4394 | RSS: Main: 177250304 10:28:57 INFO - PID 4394 | 10:29:00 INFO - PID 4394 | Cycle 1(1): loaded http://localhost:37329/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37329/tests/kraken/driver.html?testName=json-parse-financial) 10:29:00 INFO - PID 4394 | RSS: Main: 177602560 10:29:00 INFO - PID 4394 | 10:29:02 INFO - PID 4394 | Cycle 1(1): loaded http://localhost:37329/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37329/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:29:02 INFO - PID 4394 | RSS: Main: 177586176 10:29:02 INFO - PID 4394 | 10:29:04 INFO - PID 4394 | Cycle 1(1): loaded http://localhost:37329/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37329/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:29:05 INFO - PID 4394 | RSS: Main: 177717248 10:29:05 INFO - PID 4394 | 10:29:07 INFO - PID 4394 | Cycle 1(1): loaded http://localhost:37329/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37329/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:29:08 INFO - PID 4394 | RSS: Main: 177942528 10:29:08 INFO - PID 4394 | 10:29:10 INFO - PID 4394 | Cycle 1(1): loaded http://localhost:37329/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37329/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:29:11 INFO - PID 4394 | RSS: Main: 178180096 10:29:11 INFO - PID 4394 | 10:29:14 INFO - PID 4394 | Cycle 1(1): loaded http://localhost:37329/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37329/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:29:15 INFO - PID 4394 | RSS: Main: 178270208 10:29:15 INFO - PID 4394 | 10:29:17 INFO - PID 4394 | Cycle 1(1): loaded http://localhost:37329/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37329/tests/kraken/driver.html?testName=ai-astar) 10:29:17 INFO - PID 4394 | RSS: Main: 179474432 10:29:17 INFO - PID 4394 | 10:29:17 INFO - PID 4394 | __start_tp_report 10:29:17 INFO - PID 4394 | _x_x_mozilla_page_load 10:29:17 INFO - PID 4394 | _x_x_mozilla_page_load_details 10:29:17 INFO - PID 4394 | |i|pagename|runs| 10:29:17 INFO - PID 4394 | |0;ai-astar;104;108;99;108;114;111;112;110;112;110 10:29:17 INFO - PID 4394 | |1;audio-beat-detection;151;120;166;187;133;150;151;120;167;133 10:29:17 INFO - PID 4394 | |2;audio-dft;163;162;163;162;161;162;167;167;167;164 10:29:17 INFO - PID 4394 | |3;audio-fft;74;75;75;149;76;74;76;89;99;75 10:29:17 INFO - PID 4394 | |4;audio-oscillator;81;81;132;81;81;81;129;81;82;130 10:29:17 INFO - PID 4394 | |5;imaging-gaussian-blur;115;115;114;117;114;115;115;115;114;117 10:29:17 INFO - PID 4394 | |6;imaging-darkroom;150;152;152;151;151;150;151;151;150;150 10:29:17 INFO - PID 4394 | |7;imaging-desaturate;94;99;94;95;94;98;94;94;93;94 10:29:17 INFO - PID 4394 | |8;json-parse-financial;53;54;55;52;56;56;56;59;53;53 10:29:17 INFO - PID 4394 | |9;json-stringify-tinderbox;54;55;54;54;56;54;54;54;54;54 10:29:17 INFO - PID 4394 | |10;stanford-crypto-aes;79;78;87;79;78;78;77;80;78;77 10:29:17 INFO - PID 4394 | |11;stanford-crypto-ccm;131;145;137;128;131;126;133;123;132;163 10:29:17 INFO - PID 4394 | |12;stanford-crypto-pbkdf2;196;194;182;180;178;186;178;183;179;178 10:29:17 INFO - PID 4394 | |13;stanford-crypto-sha256-iterative;77;70;69;69;78;68;67;67;69;69 10:29:17 INFO - PID 4394 | __end_tp_report 10:29:17 INFO - PID 4394 | __start_cc_report 10:29:17 INFO - PID 4394 | _x_x_mozilla_cycle_collect,1012 10:29:17 INFO - PID 4394 | __end_cc_report 10:29:17 INFO - PID 4394 | __startTimestamp1500744557379__endTimestamp 10:29:17 INFO - PID 4394 | 10:29:17 INFO - PID 4394 | ------- Summary: start ------- 10:29:17 INFO - PID 4394 | Number of tests: 14 10:29:17 INFO - PID 4394 | 10:29:17 INFO - PID 4394 | [#0] ai-astar Cycles:10 Average:108.80 Median:111.50 stddev:4.42 (4.0%) stddev-sans-first:4.33 10:29:17 INFO - PID 4394 | Values: 104.0 108.0 99.0 108.0 114.0 111.0 112.0 110.0 112.0 110.0 10:29:17 INFO - PID 4394 | 10:29:17 INFO - PID 4394 | [#1] audio-beat-detection Cycles:10 Average:147.80 Median:151.00 stddev:21.72 (14.4%) stddev-sans-first:23.01 10:29:17 INFO - PID 4394 | Values: 151.0 120.0 166.0 187.0 133.0 150.0 151.0 120.0 167.0 133.0 10:29:17 INFO - PID 4394 | 10:29:17 INFO - PID 4394 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.50 stddev:2.35 (1.4%) stddev-sans-first:2.47 10:29:17 INFO - PID 4394 | Values: 163.0 162.0 163.0 162.0 161.0 162.0 167.0 167.0 167.0 164.0 10:29:17 INFO - PID 4394 | 10:29:17 INFO - PID 4394 | [#3] audio-fft Cycles:10 Average:86.20 Median:75.50 stddev:23.56 (31.2%) stddev-sans-first:24.58 10:29:17 INFO - PID 4394 | Values: 74.0 75.0 75.0 149.0 76.0 74.0 76.0 89.0 99.0 75.0 10:29:17 INFO - PID 4394 | 10:29:17 INFO - PID 4394 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:81.00 stddev:23.77 (29.4%) stddev-sans-first:24.60 10:29:17 INFO - PID 4394 | Values: 81.0 81.0 132.0 81.0 81.0 81.0 129.0 81.0 82.0 130.0 10:29:17 INFO - PID 4394 | 10:29:17 INFO - PID 4394 | [#5] imaging-gaussian-blur Cycles:10 Average:115.10 Median:115.00 stddev:1.10 (1.0%) stddev-sans-first:1.17 10:29:17 INFO - PID 4394 | Values: 115.0 115.0 114.0 117.0 114.0 115.0 115.0 115.0 114.0 117.0 10:29:17 INFO - PID 4394 | 10:29:17 INFO - PID 4394 | [#6] imaging-darkroom Cycles:10 Average:150.80 Median:151.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 10:29:17 INFO - PID 4394 | Values: 150.0 152.0 152.0 151.0 151.0 150.0 151.0 151.0 150.0 150.0 10:29:17 INFO - PID 4394 | 10:29:17 INFO - PID 4394 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:94.00 stddev:1.97 (2.1%) stddev-sans-first:2.06 10:29:17 INFO - PID 4394 | Values: 94.0 99.0 94.0 95.0 94.0 98.0 94.0 94.0 93.0 94.0 10:29:17 INFO - PID 4394 | 10:29:17 INFO - PID 4394 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.50 stddev:2.11 (3.8%) stddev-sans-first:2.15 10:29:17 INFO - PID 4394 | Values: 53.0 54.0 55.0 52.0 56.0 56.0 56.0 59.0 53.0 53.0 10:29:17 INFO - PID 4394 | 10:29:17 INFO - PID 4394 | [#9] json-stringify-tinderbox Cycles:10 Average:54.30 Median:54.00 stddev:0.67 (1.2%) stddev-sans-first:0.71 10:29:17 INFO - PID 4394 | Values: 54.0 55.0 54.0 54.0 56.0 54.0 54.0 54.0 54.0 54.0 10:29:17 INFO - PID 4394 | 10:29:17 INFO - PID 4394 | [#10] stanford-crypto-aes Cycles:10 Average:79.10 Median:78.50 stddev:2.92 (3.7%) stddev-sans-first:3.10 10:29:17 INFO - PID 4394 | Values: 79.0 78.0 87.0 79.0 78.0 78.0 77.0 80.0 78.0 77.0 10:29:17 INFO - PID 4394 | 10:29:17 INFO - PID 4394 | [#11] stanford-crypto-ccm Cycles:10 Average:134.90 Median:132.50 stddev:11.58 (8.7%) stddev-sans-first:12.20 10:29:17 INFO - PID 4394 | Values: 131.0 145.0 137.0 128.0 131.0 126.0 133.0 123.0 132.0 163.0 10:29:17 INFO - PID 4394 | 10:29:17 INFO - PID 4394 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.40 Median:182.50 stddev:6.65 (3.6%) stddev-sans-first:5.27 10:29:17 INFO - PID 4394 | Values: 196.0 194.0 182.0 180.0 178.0 186.0 178.0 183.0 179.0 178.0 10:29:17 INFO - PID 4394 | 10:29:17 INFO - PID 4394 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:69.00 stddev:3.92 (5.7%) stddev-sans-first:3.32 10:29:17 INFO - PID 4394 | Values: 77.0 70.0 69.0 69.0 78.0 68.0 67.0 67.0 69.0 69.0 10:29:17 INFO - PID 4394 | -------- Summary: end -------- 10:29:17 INFO - PID 4394 | 10:29:17 INFO - PID 4394 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 10:29:18 INFO - TEST-INFO | 4394: exit 0 10:29:18 INFO - TEST-OK | kraken | took 63080ms 10:29:18 INFO - SUITE-END | took 1175s 10:29:18 INFO - Completed test suite (00:19:36) 10:29:18 INFO - javascript benchmark 10:29:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8511.48146144638, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3121.438141134595, 3150.952735708964, 3157.431662300786, 3167.540706597542, 3218.404595149896, 6058.848528786777, 6202.286737025243, 6204.720787564559, 6221.937780622198, 6230.563860529759, 6029.186059881915, 6148.38516148386, 6150.138980542716, 6155.661438620874, 6158.56890017699, 5541.445855414467, 5577.358603760558, 5693.686847223401, 5704.344000439961, 5705.572082093839, 5670.744816483248, 5684.37471878093, 5723.5135013523695, 5736.139579063132, 5770.163326317703, 589.0915167479477, 5572.275604171452, 5587.357453892813, 5694.288213973254, 5697.6866272355, 5607.971960140214, 5619.381867994517, 5694.715264236813, 5698.116791897262, 5705.800296989627, 5567.331920169606, 5571.721413929287, 5671.659700417947, 5675.120356344773, 5686.601937864351, 5993.850153746148, 6063.333033366326, 6175.814725558241, 6180.103884936704, 6217.720202590895, 6450.774222902222, 6600.570962887445, 6633.4029937305395, 6703.430208432289, 6720.462363010947, 6531.477481801445, 6618.86762264752, 6703.765368212138, 6732.057511948331, 6769.0861733665815, 6107.4808641265545, 6140.324564297879, 6157.230346206724, 6182.69086545671, 6225.470834979077, 6759.121314229119, 6782.694778734969, 6854.554453960476, 6858.3827455529245, 6884.931150688429, 6382.106505089291, 6388.361163883667, 6491.123698300763, 6521.576097553644, 6524.314946930599, 6626.204855417381, 6672.733090676318, 6679.499037572202, 6680.23177334603, 6718.361755633207, 6551.705173267119, 6616.933830661632, 6667.233268174222, 6670.299618540081, 6674.933250667431, 6482.546221764431, 6523.0, 6588.505862060365, 6607.14107166075, 6622.1722284714415, 5307.65500242483, 5322.733863306819, 5327.147656375039, 5344.625876188629, 5359.678419294854, 4549.044700612908, 4595.494495605481, 4603.332516785047, 4611.446626404853, 4628.352030715702, 5654.9151762723595, 5680.318361796611, 5740.56945729072, 5745.626534275342, 5810.1865738796605, 6644.036614690843, 6654.068430419745, 6693.598384096969, 6712.228093769181, 6721.66391680414, 5716.256886604715, 5752.194692743019, 5827.650340979555, 5835.824925252249, 5840.094785308284, 5736.139579063174, 5777.62445441045, 5787.855303617359, 5819.301683797971, 5845.532357411397, 6399.424051835357, 6496.512761542903, 6529.2817790043055, 6530.444912182423, 6534.052562378429, 6620.2386725527185, 6621.735130594722, 6693.1298931138645, 6714.261431242462, 6718.39534441883, 6395.488360931021, 6402.263739669811, 6412.583182093149, 6467.741290348334, 6498.707558159988, 6511.34886511345, 6546.705398256994, 6591.538592298493, 6602.20773507163, 6625.304343043911, 6640.900386494303, 6649.202095748541, 6657.500687448364, 6738.831529211613, 6742.460603151834, 6372.522060845363, 6419.550631455753, 6437.806865794034, 6470.28826829039, 6527.379898909596, 6470.773522926675, 6477.611343319416, 6479.060536222316, 6494.577852439576, 6527.771527996498, 6368.649724265025, 6456.709448074754, 6462.0, 6465.385788350287, 6465.612063276219, 6400.55196136266, 6484.286728459771, 6488.643124628191, 6579.374959378852, 6595.142631457879, 6191.535634827316, 6284.24589049317, 6296.6851657417865, 6308.116863639002, 6385.946318857336], "value": 6016.175818060386, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [797.5932274539987, 824.6948629007267, 842.70926530347, 845.0113367360188, 1157.4733496259203, 30847.537286940686, 32488.67511324889, 42991.140177196474, 43384.56615433845, 43614.12771744563, 43951.78024109883, 43958.0, 44431.77784111083, 44433.77783111088, 44520.77739611305, 7716.035495563068, 7862.410319226081, 7871.685132594718, 7872.488288261245, 7906.486078404914, 7803.18066603007, 7920.9207907921045, 7926.445148839583, 7927.682892684285, 7972.521648701097, 7949.244821741925, 7975.162607926171, 7987.241212084843, 7995.400344974121, 7997.440179187459, 7900.367970562341, 7903.841923161504, 7910.604469776517, 7936.087349954742, 7955.681772729084, 7786.805329866742, 7863.0, 7863.56750378729, 7864.2922137007945, 7868.842623147505, 40107.0, 40393.39409908854, 40399.39400908989, 40430.79784601058, 40468.190636187406, 3555.928881422357, 3608.0438683748825, 3611.331903597843, 3616.6021737608844, 3618.4029635110173, 31869.0, 31935.361292774014, 31941.680583194102, 31946.361072778647, 32047.83976080128, 4750.239961606161, 4907.092187945206, 4942.654014219006, 4958.3306253655655, 4979.7261150636705, 188741.0, 189086.0, 189753.0, 190034.9999999986, 190109.0, 49402.50597494051, 49411.0, 49459.75270123698, 51719.22421163686, 53096.73451632717, 54828.451715483134, 54863.17705234425, 54957.0, 54991.45008549863, 55030.44969550333, 16033.518994430186, 16247.593810154603, 16369.590760231089, 16371.099589522453, 16383.918080409521, 12795.23228606268, 12804.423800928795, 12806.359682015862, 12814.67963300925, 13126.212427254395, 14930.477433289783, 14936.626584335478, 14974.251287435802, 15111.54665360041, 15190.392384304725, 5762.366139724627, 5870.882582348329, 5922.644641321448, 5953.940460595339, 5971.4327138921735, 997.9750506237402, 1004.1314263162458, 1016.8576399304103, 1041.0890470838017, 1051.3113910388709, 22997.540049198924, 23071.53856922852, 23679.526409471713, 28682.282942926176, 29271.511921486486, 1087.9891201088046, 1113.2652449383368, 1118.703543560957, 1119.4123085380077, 1124.8650161980615, 12642.810357844639, 12666.176698514568, 12807.61577152687, 12868.163569367962, 12922.483100675867, 228796.0, 230120.0, 230230.0, 234030.0, 237049.0, 58452.12321815176, 59247.0, 59583.0, 59639.40360596425, 59653.40346596565, 1495.349522957517, 1507.8341382447923, 1509.4716849102726, 1518.916459594733, 1525.7406240939067, 26762.732372676022, 27789.861050694617, 27998.86000569984, 28065.859670701517, 28140.71859281381, 51972.74013629908, 53212.201816972, 53268.4673153279, 53424.0, 53443.198352023974, 209518.0, 209646.0, 210916.0, 211246.0, 211969.0, 38486.42270365891, 38517.6148238514, 38718.61281387263, 39062.0, 39064.41403379008, 46939.76530117328, 47011.52988470208, 47067.529324707684, 47248.2912756302, 47259.0, 30959.0, 35156.296874062886, 35476.113097172776, 36393.45409818802, 36521.45217821788, 35079.0, 35299.0, 35689.46465802963, 35701.64298356983, 36030.8198459006, 38002.42996355112, 39873.60126398699, 39936.60063399445, 39963.2007359857, 40053.19893602053, 33644.83177584096, 34688.306233875686, 35131.29737405289, 35287.47068793919, 35415.468767967985, 23414.88292558526, 24567.262982110566, 24653.876730616234, 25615.743842561336, 26484.073057442896], "value": 18120.65125136058, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.7959534567555, 579.7912751409489, 583.2767368463102, 584.2054805464568, 606.5632744424015, 22294.88852555737, 22952.88523557384, 23202.0, 23210.535789284226, 23227.187048453306, 21880.12479500818, 22104.447388815286, 22253.66619500709, 22262.666060009113, 22550.21074262401, 6496.480281577463, 6660.966695166518, 6668.399844014038, 6675.699593518303, 6677.666116694146, 6273.278572964099, 6542.738290468375, 6563.245226798931, 6583.407493325623, 6610.933890661104, 6536.54244202906, 6536.836579085513, 6538.6076835389795, 6549.836254093662, 6551.1483507144, 6557.836054098638, 6558.540902136876, 6560.868782624369, 6564.245111812155, 6569.737210511574, 6100.847478813021, 6105.908411373788, 6112.877742445171, 6116.4800991915745, 6137.386261373871, 28327.15018549447, 28953.85523072371, 29243.415131697246, 29865.850670746724, 30390.54414183789, 1823.881447705895, 1877.2678655324298, 1882.407041781848, 1882.4540883143873, 1886.8490520758307, 18683.15925783343, 19374.612507749905, 19377.4186774397, 19451.221951121937, 19488.317908873265, 2205.63607004844, 2290.8854557272234, 2305.273838740808, 2335.859848409101, 2352.5882970480097, 130985.0, 133548.0, 134609.32695336558, 134612.0, 135058.0, 14452.349644266033, 15408.537743867702, 15440.768388474182, 15510.922445387701, 16039.358425663077, 23545.29364119079, 23577.646335304984, 23598.528029439316, 23631.645525317133, 23643.881780590986, 10140.138088262433, 10170.694879153638, 10270.178385729123, 10297.17622590191, 10452.73868153287, 7350.485466017434, 9486.383385080086, 9527.857082143773, 9661.13049825505, 9663.855042174373, 8109.878351824727, 9197.034311397341, 9222.0, 9365.765855853659, 9472.57373418184, 2777.125205560242, 2778.2776478115834, 2780.902668406596, 2874.6262985812127, 2876.6548014238424, 903.9361516204807, 907.6006557114848, 950.8193443245762, 963.720521048902, 965.3001573859036, 18796.906015469835, 19265.325713599956, 19563.413097607096, 19763.703544446846, 20108.39674809758, 987.8863930647924, 997.7677568203408, 1008.5713571731984, 1023.155896385485, 1040.6721882606955, 9920.4543750093, 12969.35153242353, 13800.17198968045, 14091.577252682437, 14156.221407822462, 483544.0, 484699.0, 502032.0, 504428.0, 505013.0, 117967.41016295036, 119174.0, 120274.0, 121142.39428802975, 123769.38115309365, 1251.5807204586383, 1252.511520507003, 1290.6832236136158, 1292.4377895615437, 1296.3647812571771, 20425.85528519484, 20579.58840823145, 20707.378778636667, 21411.0, 21498.355049348545, 56845.43154568567, 56866.43133568612, 58618.4138158613, 58794.0, 59576.0, 70801.93797093151, 71495.0, 71752.64123679348, 71759.64120179365, 72057.63971180111, 12434.440450179945, 12923.612291631267, 14196.92901535527, 14458.277086145441, 14880.255987200813, 22527.549449011254, 22929.770702292764, 22979.540409192057, 23073.423164421023, 23170.0, 17321.653566928842, 18201.726974095134, 19296.517587060436, 19336.0, 19378.03109844474, 16289.18554072268, 16494.570976534407, 17410.39063632767, 17454.127293635014, 17872.55318617045, 19089.522761931064, 19907.203711851365, 20073.397798066082, 20107.899460502606, 20131.899340503205, 14822.40710371573, 15026.0, 15043.699126017636, 15050.172240526876, 15073.924630376778, 17432.73850892263, 18200.089995499908, 18267.269309227482, 18405.355812546495, 18424.35514756977], "value": 12056.739833691943, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1366.6173471428, 1368.8631136886313, 1378.5657517881873, 1390.9721805563888, 1415.0, 13517.662058448532, 14177.07848989815, 14260.073095248814, 14260.215688137148, 14262.429502819889, 13424.060315777899, 13857.93071034646, 14447.638809029779, 14509.274536273197, 14516.854831451683, 2587.573050446674, 2660.1620489545826, 2662.2146466792246, 2668.4262883480046, 2672.4521473097966, 2585.6897172339345, 2597.2467984284535, 2645.7354264573487, 2690.515707172708, 2691.058129654615, 2609.712931577525, 2613.7516935891153, 2633.802464815137, 2639.1290874011625, 2640.471905618874, 2548.630448584954, 2595.5976823592373, 2610.5040042391884, 2610.843349399042, 2612.542805009116, 2533.1134103063964, 2548.643189953408, 2555.872206389673, 2591.08016654087, 2606.569915963864, 13540.187588744708, 13834.377453014638, 13842.546532614131, 13844.446222151102, 13856.792148117785, 6975.755848545276, 7235.529690570096, 7235.746748863765, 7236.746713865042, 7241.746538871167, 4876.0, 5058.696478211319, 5107.0, 5113.437521872591, 5173.8189163379475, 1812.1754601656214, 1847.8798878072882, 1854.1378259109445, 1896.0519740129935, 1902.2391043582538, 22469.325920222254, 22913.65629515542, 23034.53930921389, 23052.884735576215, 23068.0, 6700.83247918806, 6866.622335771581, 7072.469564782662, 7076.964615176891, 7127.358537731629, 15385.923070384577, 15464.768028479582, 15465.14941678196, 15528.14595197275, 15528.5341439757, 6797.28628494001, 7277.818054548678, 7318.268173182639, 7385.852282954311, 7408.7036518539735, 6781.6609169541325, 6844.657767111724, 6864.416524595365, 6868.965655171693, 6955.02629631852, 4584.404027476474, 5156.1750119980625, 5257.369115706063, 5266.578673706094, 5274.630775845654, 1259.6221133659865, 1470.4265336518765, 1497.7154340675236, 1498.0637101811367, 1507.9396824127132, 868.1665601023088, 882.2192359761657, 888.1473785166313, 914.9085091490931, 920.604140219712, 8480.915190848136, 8525.19010693983, 8544.273736732448, 8746.475211487332, 8823.426477278956, 912.762681702762, 932.6083045121065, 992.1021475564626, 993.101243374747, 1009.2178561614808, 4837.080954618611, 5244.239585260192, 5336.553093614176, 5384.246205531229, 5389.056915039931, 18441.446756597325, 19149.712754308697, 19443.02784860751, 19529.218831246875, 19576.021198939998, 18355.724664130048, 18917.33789317395, 19108.808911910703, 19271.22915083381, 19337.613247734967, 10554.155667546578, 10757.731056723487, 10857.185711071543, 10876.945615271872, 10895.291806032583, 7157.212706602374, 7949.284564389232, 8013.358931285366, 8067.3142782864115, 8133.389995750461, 16215.67568648644, 16501.669966600362, 16807.66384672324, 17065.232064557375, 17076.316947321968, 16412.425565105164, 16729.079900605582, 16835.074070925726, 17133.858267716536, 17198.398056067977, 9104.726858194264, 9317.673881414117, 9319.0, 9341.392809467363, 9354.391964522285, 11653.184277100521, 12114.697132571404, 12547.93726031364, 12975.935120324339, 13108.737825243632, 10046.69859904204, 10478.37129772216, 10745.355278683304, 10781.137508999418, 10838.783224335311, 10116.89883101189, 10528.315659482416, 10531.21015923824, 10719.785604287714, 10885.129189664649, 9547.570359333708, 9642.0, 9651.469169195481, 9652.083052110038, 9661.613535458502, 6335.588186767845, 6567.441767449629, 6675.566088204251, 6856.242332359214, 6970.616616086164, 6727.394534491919, 7009.0, 7064.258252883374, 7080.4335653148655, 7149.606771627402], "value": 6293.065104536615, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [496.79813601339384, 502.64061196244677, 515.7962604771118, 523.0767695018292, 527.7176710459902, 6043.220118745371, 6068.848278793027, 6074.149619053336, 6116.602420842648, 6142.341567776709, 5870.060790273557, 5977.402259774031, 6035.637861728299, 6037.637741735499, 6055.0, 4805.279208118775, 4885.291632713254, 4888.951110488885, 4899.167141585921, 4937.358143441347, 4797.928031079537, 4912.21404575268, 4920.97539512302, 4935.802567897298, 4948.703077815325, 4787.066522028206, 4832.516748325174, 4863.440704319013, 4864.221724524077, 4883.243097319921, 4863.708177509361, 4871.951280487203, 4885.511448855122, 4934.185859333205, 4992.45083040867, 4429.534898835608, 4430.224710675619, 4454.33185022246, 4454.510003899569, 4459.662101369576, 5951.797834801108, 5977.3723759005115, 5997.4510832896285, 5997.6701281429505, 6010.2186715726675, 5559.694216818073, 5562.805301814417, 5587.161925711135, 5602.187682786014, 5672.40439753824, 6314.5895516791725, 6435.710393032325, 6435.935640643581, 6451.322656109399, 6458.870822583522, 4802.27965805132, 4837.1776797944085, 4839.806407743686, 4865.489123642037, 4870.512948705101, 6774.525783195129, 6793.218779840283, 6806.421454176401, 6812.727490900358, 6840.760573379957, 4920.114379411741, 4947.703137811743, 4957.231629097496, 4974.253861920741, 4986.152354099811, 4989.301497790312, 5033.47148549397, 5037.899242015213, 5040.798368065236, 5064.720875605992, 5609.86569474264, 5623.156526521055, 5647.407022262685, 5661.66030038199, 5674.914876276859, 6033.728482218311, 6450.935490645127, 6478.352164783484, 6503.577267477599, 6506.219253689587, 1651.9504414867574, 1712.734526148449, 1731.6796392667397, 1739.3390511605762, 1742.668892910343, 1191.8212268159673, 1209.195884736658, 1217.829503869459, 1227.5212667059855, 1229.9668278645981, 5643.379228284885, 5685.144301369513, 5707.0, 5726.455986681259, 5727.140928860705, 6430.7106180222, 6496.837579060467, 6561.1470508833545, 6564.86870262592, 6686.13080299558, 5638.633488823213, 5651.802186923438, 5672.97163514188, 5682.715864206773, 5716.342620598684, 3524.242287908112, 3546.804925729058, 3558.1638314995957, 3561.30554541867, 3562.3460521910824, 6468.417842394113, 6470.935290647128, 6506.544541882023, 6510.7721229756735, 6520.804375868732, 6667.733290668319, 6753.729850805913, 6815.318468153145, 6850.417714494224, 6871.587704737732, 6247.250329960434, 6323.146375239284, 6370.74517019314, 6375.171227740364, 6416.550841441054, 6539.757446085228, 6630.801075967729, 6633.734650613921, 6634.469242460688, 6637.933620663732, 6477.255115661759, 6535.673216339259, 6536.705848236746, 6575.704093315717, 6605.702743376463, 6380.321513852768, 6413.262474815456, 6426.943378118957, 6456.354364563506, 6458.806235812933, 5358.276632654542, 5379.67721936685, 5430.375506816767, 5467.605760531039, 5475.4250803665045, 6310.52671049664, 6510.707018184098, 6592.978088396306, 6624.9337506624315, 6676.499262555425, 6204.162438070803, 6407.263164736115, 6411.185344719885, 6434.517411194086, 6462.547621666438, 6395.232572091379, 6412.551121421642, 6449.484041276781, 6460.547761656827, 6489.221293444817, 6126.938730612636, 6299.496040316855, 6301.527385446018, 6301.779437719842, 6403.327650596807, 6394.712237949397, 6415.743370265323, 6421.743130274736, 6423.164988551645, 6526.184226971629, 6177.444030037318, 6200.395833749746, 6223.844403889939, 6310.810675679737, 6328.588641738273], "value": 4991.270157197391, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [872.6727477196048, 889.2441424788926, 890.9821803563925, 903.93672442929, 914.2594498456251, 18181.7272740909, 19223.0, 19229.615407691854, 19237.326693565727, 21509.569808603857, 20984.790152098474, 21604.89197554014, 21756.8912155439, 21923.342299730994, 21924.0, 1002.3584905660365, 1031.9896801031969, 1033.5504055735742, 1036.3678156324636, 1038.226521241676, 1019.1235537437798, 1032.5353590884095, 1058.1693370704, 1080.5137688040375, 1086.353619596343, 1127.2053202492223, 1132.4451019000671, 1135.125953016177, 1139.692283083571, 1140.5095808802212, 1113.2708076210095, 1115.046635126971, 1118.1893127482551, 1120.63019203663, 1120.9159313051555, 816.4285000499674, 816.5264146794844, 816.6570040582969, 818.1613845808035, 818.6193420059641, 18281.360152394736, 18282.0, 18283.360082397186, 18655.347062852736, 19834.60330793376, 19964.3012494562, 20795.5840883183, 21193.470163246042, 21241.04415301315, 21253.468663283387, 15516.991540456454, 15553.766693499607, 15766.290516926765, 15796.05223686571, 15854.920725396414, 3552.626974167701, 3608.548931383577, 3617.5297211362354, 3619.7647152934974, 3620.0406892173596, 124392.37803811014, 126255.36872315672, 126934.36532817369, 127101.99999999907, 129245.35377323053, 16330.836691632932, 16681.416150434678, 16717.164141793106, 16819.0, 16823.242954067096, 30304.242393939887, 30958.69041309558, 31084.533731994037, 31134.37731245408, 31157.376852462825, 8576.313894888393, 8576.485410875368, 8586.39895207342, 8629.22336989674, 8663.653453861774, 3928.273269445162, 3961.1285517186175, 3964.6035396460125, 3988.222296652183, 3991.341428664296, 5072.289879416885, 5719.7140142992685, 5921.970390148022, 5929.644221346733, 5976.342602313742, 1082.0640146273417, 1117.1565468071553, 1122.1079242002627, 1130.8416821644976, 1136.9602063927723, 666.8132922781532, 685.7325642999234, 690.8687349403698, 691.5366704308126, 699.433458898294, 11725.824112638316, 11782.94108529469, 12147.210431321935, 12269.607426551915, 12379.93810030962, 672.1530871102349, 673.1282988529865, 681.4105798484276, 684.7466437418087, 689.4105539763531, 5898.498627616701, 6033.9698301508215, 6042.063480160494, 6057.969710151421, 6453.096566480603, 101398.0, 103488.48255758673, 103740.48129759303, 104120.0, 105101.47449262705, 82377.58811205905, 83086.58456707677, 87189.56405217934, 89617.0, 92926.0, 73907.26092739111, 77602.0, 79088.0, 79624.0, 80163.0, 11942.402879856147, 12239.20445171061, 12316.568920087753, 12365.567205147776, 12544.560940367044, 36315.55266710015, 37039.21911276474, 37597.62402375941, 38098.42852357272, 38112.0, 67402.32597674157, 67414.0, 68758.0, 69272.0, 73865.63067184844, 17843.37548185807, 18314.26742930268, 18667.90666046661, 19442.90278548598, 19955.700664490334, 20376.0, 21079.8946005269, 21110.57778844445, 21353.25263615766, 21750.12999480003, 17806.732899006267, 18556.536086597403, 18632.813671863107, 18870.433886983414, 19057.428277151706, 18699.25202991865, 18930.053497325353, 19258.133383997472, 19296.8070319295, 19340.22639094477, 17628.0, 18525.53686157857, 18542.907285463487, 18756.155972980974, 18771.90614046921, 12902.290374029519, 13381.063325567116, 13473.730525389241, 13969.742723154965, 14736.410543578137, 13264.403101860247, 13480.73038539204, 13884.305784710523, 14304.0, 14445.855541444871], "value": 9208.825167087005, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1540.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 108.0, 99.0, 108.0, 114.0, 111.0, 112.0, 110.0, 112.0, 110.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 120.0, 166.0, 187.0, 133.0, 150.0, 151.0, 120.0, 167.0, 133.0], "value": 147.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 162.0, 161.0, 162.0, 167.0, 167.0, 167.0, 164.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 149.0, 76.0, 74.0, 76.0, 89.0, 99.0, 75.0], "value": 86.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 132.0, 81.0, 81.0, 81.0, 129.0, 81.0, 82.0, 130.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 114.0, 117.0, 114.0, 115.0, 115.0, 115.0, 114.0, 117.0], "value": 115.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 152.0, 152.0, 151.0, 151.0, 150.0, 151.0, 151.0, 150.0, 150.0], "value": 150.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 99.0, 94.0, 95.0, 94.0, 98.0, 94.0, 94.0, 93.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 55.0, 52.0, 56.0, 56.0, 56.0, 59.0, 53.0, 53.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 54.0, 56.0, 54.0, 54.0, 54.0, 54.0, 54.0], "value": 54.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 87.0, 79.0, 78.0, 78.0, 77.0, 80.0, 78.0, 77.0], "value": 79.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 145.0, 137.0, 128.0, 131.0, 126.0, 133.0, 123.0, 132.0, 163.0], "value": 134.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 194.0, 182.0, 180.0, 178.0, 186.0, 178.0, 183.0, 179.0, 178.0], "value": 183.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 70.0, 69.0, 69.0, 78.0, 68.0, 67.0, 67.0, 69.0, 69.0], "value": 70.3, "unit": "score"}]}]} 10:29:18 INFO - Return code: 0 10:29:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:29:18 INFO - # TBPL SUCCESS # 10:29:18 INFO - Running post-action listener: _package_coverage_data 10:29:18 INFO - Running post-action listener: _resource_record_post_action 10:29:18 INFO - [mozharness: 2017-07-22 17:29:18.668086Z] Finished run-tests step (success) 10:29:18 INFO - Running post-run listener: _resource_record_post_run 10:29:18 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 12288; Write bytes: 436588544; Read time: 380; Write time: 306948 10:29:18 INFO - TinderboxPrint: CPU usage
13.2% 10:29:18 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 380 10:29:18 INFO - TinderboxPrint: I/O write bytes / time
436,588,544 / 306,948 10:29:18 INFO - TinderboxPrint: CPU idle
8,274.4 (86.8%) 10:29:18 INFO - TinderboxPrint: CPU user
1,201.6 (12.6%) 10:29:18 INFO - TinderboxPrint: Swap in / out
0 / 0 10:29:18 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 107556864; Read time: 176; Write time: 83080 10:29:18 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 10:29:18 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 329031680; Read time: 196; Write time: 223868 10:29:19 INFO - Running post-run listener: _upload_blobber_files 10:29:19 INFO - Blob upload gear active. 10:29:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:29:19 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 10:29:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:29:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:29:19 INFO - (blobuploader) - INFO - Open directory for files ... 10:29:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:29:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:29:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:29:20 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:29:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:29:20 INFO - (blobuploader) - INFO - Done attempting. 10:29:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:29:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:29:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:29:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:29:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:29:22 INFO - (blobuploader) - INFO - Done attempting. 10:29:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:29:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:29:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:29:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:29:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:29:30 INFO - (blobuploader) - INFO - Done attempting. 10:29:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:29:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:29:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:29:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:29:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:29:30 INFO - (blobuploader) - INFO - Done attempting. 10:29:30 INFO - (blobuploader) - INFO - Iteration through files over. 10:29:30 INFO - Return code: 0 10:29:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:29:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:29:30 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a7620dc61114b63860a7bc77d8e8fc35f9d1f28532acc7e6943fb311edb2fef3b909d8fd451353c486d5d24419da3df65c2c5f28a9f19a8f9c61aafc9d3ff507", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cff9f48d840ea9adbc93563e97477f118db0b7a1eaf7bbc7f906f851c522d4c1f8c5551c1398973ba42c1d222454032fd92d8ee4618772b7bf6056eeb04a29ca", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b4a8355ce16f5e88f0f2dc3d49309fe01883906d3f951d87e06d8e3cb144b1ee5253c43a8a5a007bbf2b84c583e63e49d08175efc5a55e441e29267d301a3514", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9f0243dc90fd15be04b1ebf008a64b377e669556c380c0663bded99fc03213ff168a97f376553d97ca0d4835f7b742b9e20ee9fe85b713779f3ddf35093e6894"} 10:29:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:29:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:29:30 INFO - Contents: 10:29:30 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a7620dc61114b63860a7bc77d8e8fc35f9d1f28532acc7e6943fb311edb2fef3b909d8fd451353c486d5d24419da3df65c2c5f28a9f19a8f9c61aafc9d3ff507", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cff9f48d840ea9adbc93563e97477f118db0b7a1eaf7bbc7f906f851c522d4c1f8c5551c1398973ba42c1d222454032fd92d8ee4618772b7bf6056eeb04a29ca", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b4a8355ce16f5e88f0f2dc3d49309fe01883906d3f951d87e06d8e3cb144b1ee5253c43a8a5a007bbf2b84c583e63e49d08175efc5a55e441e29267d301a3514", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9f0243dc90fd15be04b1ebf008a64b377e669556c380c0663bded99fc03213ff168a97f376553d97ca0d4835f7b742b9e20ee9fe85b713779f3ddf35093e6894"} 10:29:30 INFO - Running post-run listener: copy_logs_to_upload_dir 10:29:30 INFO - Copying logs to upload dir... 10:29:30 INFO - mkdir: /builds/slave/test/build/upload/logs 10:29:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.737463 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-07-22 10:29:30.225427) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-22 10:29:30.229019) ========= 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=fcadb68e09dcf59683000ff6000001dc-1500738863.498441-438096369 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a7620dc61114b63860a7bc77d8e8fc35f9d1f28532acc7e6943fb311edb2fef3b909d8fd451353c486d5d24419da3df65c2c5f28a9f19a8f9c61aafc9d3ff507", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cff9f48d840ea9adbc93563e97477f118db0b7a1eaf7bbc7f906f851c522d4c1f8c5551c1398973ba42c1d222454032fd92d8ee4618772b7bf6056eeb04a29ca", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b4a8355ce16f5e88f0f2dc3d49309fe01883906d3f951d87e06d8e3cb144b1ee5253c43a8a5a007bbf2b84c583e63e49d08175efc5a55e441e29267d301a3514", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9f0243dc90fd15be04b1ebf008a64b377e669556c380c0663bded99fc03213ff168a97f376553d97ca0d4835f7b742b9e20ee9fe85b713779f3ddf35093e6894"} build_url:https://queue.taskcluster.net/v1/task/Pp1sd-lkQXyYNmBkPeE-0w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011448 build_url: 'https://queue.taskcluster.net/v1/task/Pp1sd-lkQXyYNmBkPeE-0w/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a7620dc61114b63860a7bc77d8e8fc35f9d1f28532acc7e6943fb311edb2fef3b909d8fd451353c486d5d24419da3df65c2c5f28a9f19a8f9c61aafc9d3ff507", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cff9f48d840ea9adbc93563e97477f118db0b7a1eaf7bbc7f906f851c522d4c1f8c5551c1398973ba42c1d222454032fd92d8ee4618772b7bf6056eeb04a29ca", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b4a8355ce16f5e88f0f2dc3d49309fe01883906d3f951d87e06d8e3cb144b1ee5253c43a8a5a007bbf2b84c583e63e49d08175efc5a55e441e29267d301a3514", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9f0243dc90fd15be04b1ebf008a64b377e669556c380c0663bded99fc03213ff168a97f376553d97ca0d4835f7b742b9e20ee9fe85b713779f3ddf35093e6894"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-22 10:29:30.253558) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 10:29:30.253887) ========= 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=fcadb68e09dcf59683000ff6000001dc-1500738863.498441-438096369 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004446 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 10:29:30.337378) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-22 10:29:30.337701) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-22 10:29:30.338011) ========= ========= Total master_lag: 0.15 =========