builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-084 starttime: 1496048340.39 results: success (0) revision: cce4d83d2b99ffedbd67a2f40ce26e53e9ae27ab ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-29 01:59:00.387678) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-29 01:59:00.388137) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-29 01:59:00.390134) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-29 01:59:00.643529) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-29 01:59:00.643797) ========= 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=ea65d483da93c827905c2090000001f5-1496032186.124567-1132932723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-29 01:59:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.5M=0s 2017-05-29 01:59:02 (45.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.147847 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-29 01:59:00.814917) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-29 01:59:00.815187) ========= 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=ea65d483da93c827905c2090000001f5-1496032186.124567-1132932723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018598 ========= master_lag: 0.12 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-29 01:59:00.950743) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-29 01:59:00.951050) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cce4d83d2b99ffedbd67a2f40ce26e53e9ae27ab --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 cce4d83d2b99ffedbd67a2f40ce26e53e9ae27ab --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=ea65d483da93c827905c2090000001f5-1496032186.124567-1132932723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-29 01:59:03,028 truncating revision to first 12 chars 2017-05-29 01:59:03,028 Setting DEBUG logging. 2017-05-29 01:59:03,028 attempt 1/10 2017-05-29 01:59:03,028 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cce4d83d2b99?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-29 01:59:03,601 unpacking tar archive at: mozilla-central-cce4d83d2b99/testing/mozharness/ program finished with exit code 0 elapsedTime=0.876922 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-29 01:59:01.845677) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-29 01:59:01.845991) ========= script_repo_revision: cce4d83d2b99ffedbd67a2f40ce26e53e9ae27ab ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-29 01:59:01.848897) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-29 01:59:01.849161) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-29 01:59:01.857294) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 27 secs) (at 2017-05-29 01:59:01.857571) ========= /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=ea65d483da93c827905c2090000001f5-1496032186.124567-1132932723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:59:04 INFO - MultiFileLogger online at 20170529 01:59:04 in /builds/slave/test 01:59:04 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 01:59:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:59:04 INFO - {'append_to_log': False, 01:59:04 INFO - 'base_work_dir': '/builds/slave/test', 01:59:04 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 01:59:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:59:04 INFO - 'branch': 'Firefox-Non-PGO', 01:59:04 INFO - 'buildbot_json_path': 'buildprops.json', 01:59:04 INFO - 'config_files': ('talos/linux_config.py',), 01:59:04 INFO - 'default_actions': ('clobber', 01:59:04 INFO - 'read-buildbot-config', 01:59:04 INFO - 'download-and-extract', 01:59:04 INFO - 'populate-webroot', 01:59:04 INFO - 'create-virtualenv', 01:59:04 INFO - 'install', 01:59:04 INFO - 'setup-mitmproxy', 01:59:04 INFO - 'run-tests'), 01:59:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:59:04 INFO - 'download_minidump_stackwalk': True, 01:59:04 INFO - 'download_symbols': 'ondemand', 01:59:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:59:04 INFO - 'tooltool.py': '/tools/tooltool.py', 01:59:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:59:04 INFO - '/tools/misc-python/virtualenv.py')}, 01:59:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:59:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:59:04 INFO - 'gecko_profile': False, 01:59:04 INFO - 'gecko_profile_interval': 0, 01:59:04 INFO - 'installer_path': 'installer.exe', 01:59:04 INFO - 'log_level': 'info', 01:59:04 INFO - 'log_name': 'talos', 01:59:04 INFO - 'log_to_console': True, 01:59:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:59:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:59:04 INFO - 'opt_config_files': (), 01:59:04 INFO - 'pip_index': False, 01:59:04 INFO - 'suite': 'dromaeojs-e10s', 01:59:04 INFO - 'system_bits': '32', 01:59:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:59:04 INFO - 'title': 'talos-linux64-ix-084', 01:59:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:59:04 INFO - 'use_talos_json': True, 01:59:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:59:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:59:04 INFO - 'work_dir': 'build'} 01:59:04 INFO - [mozharness: 2017-05-29 08:59:04.027940Z] Running clobber step. 01:59:04 INFO - Running pre-action listener: _resource_record_pre_action 01:59:04 INFO - Running main action method: clobber 01:59:04 INFO - rmtree: /builds/slave/test/build 01:59:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:59:05 INFO - Running post-action listener: _resource_record_post_action 01:59:05 INFO - [mozharness: 2017-05-29 08:59:05.554210Z] Finished clobber step (success) 01:59:05 INFO - [mozharness: 2017-05-29 08:59:05.554310Z] Running read-buildbot-config step. 01:59:05 INFO - Running pre-action listener: _resource_record_pre_action 01:59:05 INFO - Running main action method: read_buildbot_config 01:59:05 INFO - Using buildbot properties: 01:59:05 INFO - { 01:59:05 INFO - "project": "", 01:59:05 INFO - "product": "firefox", 01:59:05 INFO - "who": "cbook@mozilla.com", 01:59:05 INFO - "installer_path": "public/build/target.tar.bz2", 01:59:05 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 01:59:05 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 01:59:05 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 01:59:05 INFO - "stage_platform": "linux64", 01:59:05 INFO - "basedir": "/builds/slave/test", 01:59:05 INFO - "buildnumber": 863, 01:59:05 INFO - "platform": "ubuntu64_hw", 01:59:05 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:59:05 INFO - "slavebuilddir": "test", 01:59:05 INFO - "taskId": "QEv2_VX1S6e24W0QWDJiZQ", 01:59:05 INFO - "branch": "mozilla-central", 01:59:05 INFO - "script_repo_revision": "production", 01:59:05 INFO - "revision": "cce4d83d2b99ffedbd67a2f40ce26e53e9ae27ab", 01:59:05 INFO - "slavename": "talos-linux64-ix-084", 01:59:05 INFO - "repo_path": "mozilla-central" 01:59:05 INFO - } 01:59:05 INFO - Finding installer, test and symbols from parent task. 01:59:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QEv2_VX1S6e24W0QWDJiZQ'}, attempt #1 01:59:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QEv2_VX1S6e24W0QWDJiZQ'}, attempt #1 01:59:06 INFO - Task dependencies: TddXRzz_SvuOenppX06GOQ 01:59:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TddXRzz_SvuOenppX06GOQ'}, attempt #1 01:59:07 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/TddXRzz_SvuOenppX06GOQ/artifacts/public/build/target.tar.bz2 01:59:07 INFO - Set test_url: https://queue.taskcluster.net/v1/task/TddXRzz_SvuOenppX06GOQ/artifacts/public/build/test_packages.json 01:59:07 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/TddXRzz_SvuOenppX06GOQ/artifacts/public/build/target.crashreporter-symbols.zip 01:59:07 INFO - Running post-action listener: _resource_record_post_action 01:59:07 INFO - [mozharness: 2017-05-29 08:59:07.532245Z] Finished read-buildbot-config step (success) 01:59:07 INFO - [mozharness: 2017-05-29 08:59:07.532469Z] Running download-and-extract step. 01:59:07 INFO - Running pre-action listener: _resource_record_pre_action 01:59:07 INFO - Running main action method: download_and_extract 01:59:07 INFO - mkdir: /builds/slave/test/build/tests 01:59:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:59:07 INFO - trying https://queue.taskcluster.net/v1/task/TddXRzz_SvuOenppX06GOQ/artifacts/public/build/target.test_packages.json 01:59:07 INFO - Downloading https://queue.taskcluster.net/v1/task/TddXRzz_SvuOenppX06GOQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 01:59:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TddXRzz_SvuOenppX06GOQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 01:59:08 INFO - Downloaded 986 bytes. 01:59:08 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 01:59:08 INFO - Using the following test package requirements: 01:59:08 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 01:59:08 INFO - u'common': [u'target.common.tests.zip'], 01:59:08 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 01:59:08 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 01:59:08 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 01:59:08 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 01:59:08 INFO - u'mozbase': [u'target.common.tests.zip'], 01:59:08 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 01:59:08 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 01:59:08 INFO - u'web-platform': [u'target.common.tests.zip', 01:59:08 INFO - u'target.web-platform.tests.zip'], 01:59:08 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 01:59:08 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 01:59:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TddXRzz_SvuOenppX06GOQ/artifacts/public/build/target.common.tests.zip 01:59:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TddXRzz_SvuOenppX06GOQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:59:08 INFO - Fetch https://queue.taskcluster.net/v1/task/TddXRzz_SvuOenppX06GOQ/artifacts/public/build/target.common.tests.zip into memory 01:59:21 INFO - Content-Length response header: 63534234 01:59:21 INFO - Bytes received: 63534234 01:59:32 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 01:59:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TddXRzz_SvuOenppX06GOQ/artifacts/public/build/target.common.tests.zip 01:59:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TddXRzz_SvuOenppX06GOQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:59:32 INFO - Fetch https://queue.taskcluster.net/v1/task/TddXRzz_SvuOenppX06GOQ/artifacts/public/build/target.common.tests.zip into memory 01:59:40 INFO - Content-Length response header: 63534234 01:59:40 INFO - Bytes received: 63534234 01:59:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TddXRzz_SvuOenppX06GOQ/artifacts/public/build/target.talos.tests.zip 01:59:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TddXRzz_SvuOenppX06GOQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 01:59:52 INFO - Fetch https://queue.taskcluster.net/v1/task/TddXRzz_SvuOenppX06GOQ/artifacts/public/build/target.talos.tests.zip into memory 01:59:53 INFO - Content-Length response header: 14447425 01:59:53 INFO - Bytes received: 14447425 01:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:59:53 INFO - trying https://queue.taskcluster.net/v1/task/TddXRzz_SvuOenppX06GOQ/artifacts/public/build/target.tar.bz2 01:59:53 INFO - Downloading https://queue.taskcluster.net/v1/task/TddXRzz_SvuOenppX06GOQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 01:59:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TddXRzz_SvuOenppX06GOQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 01:59:55 INFO - Downloaded 54193895 bytes. 01:59:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TddXRzz_SvuOenppX06GOQ/artifacts/public/build/target.tar.bz2 01:59:55 INFO - mkdir: /builds/slave/test/properties 01:59:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:59:55 INFO - Writing to file /builds/slave/test/properties/build_url 01:59:55 INFO - Contents: 01:59:55 INFO - build_url:https://queue.taskcluster.net/v1/task/TddXRzz_SvuOenppX06GOQ/artifacts/public/build/target.tar.bz2 01:59:55 INFO - Running post-action listener: _resource_record_post_action 01:59:55 INFO - Running post-action listener: set_extra_try_arguments 01:59:55 INFO - [mozharness: 2017-05-29 08:59:55.627377Z] Finished download-and-extract step (success) 01:59:55 INFO - [mozharness: 2017-05-29 08:59:55.627473Z] Running populate-webroot step. 01:59:55 INFO - Running pre-action listener: _resource_record_pre_action 01:59:55 INFO - Running main action method: populate_webroot 01:59:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:59:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:59:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:59:55 INFO - '--tppagecycles', 01:59:55 INFO - '7'], 01:59:55 INFO - 'tests': ['tsvgm']}}, 01:59:55 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:59:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:59:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:59:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:59:55 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 01:59:55 INFO - 'talos_options': ['--disable-e10s'], 01:59:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:59:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:59:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:59:55 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 01:59:55 INFO - 'talos_options': ['--disable-e10s'], 01:59:55 INFO - 'tests': ['damp', 'tps']}, 01:59:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:59:55 INFO - 'tests': ['damp', 'tps']}, 01:59:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:59:55 INFO - 'tests': ['dromaeo_dom']}, 01:59:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:59:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:59:55 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 01:59:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 01:59:55 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 01:59:55 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 01:59:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:59:55 INFO - 'tests': ['a11yr', 01:59:55 INFO - 'ts_paint', 01:59:55 INFO - 'tpaint', 01:59:55 INFO - 'sessionrestore', 01:59:55 INFO - 'sessionrestore_no_auto_restore', 01:59:55 INFO - 'tabpaint']}, 01:59:55 INFO - 'other-e10s': {'tests': ['a11yr', 01:59:55 INFO - 'ts_paint', 01:59:55 INFO - 'tpaint', 01:59:55 INFO - 'sessionrestore', 01:59:55 INFO - 'sessionrestore_no_auto_restore', 01:59:55 INFO - 'tabpaint']}, 01:59:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:59:55 INFO - 'ts_paint', 01:59:55 INFO - 'tpaint', 01:59:55 INFO - 'sessionrestore', 01:59:55 INFO - 'sessionrestore_no_auto_restore', 01:59:55 INFO - 'tabpaint']}, 01:59:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:59:55 INFO - 'ts_paint', 01:59:55 INFO - 'tpaint', 01:59:55 INFO - 'sessionrestore', 01:59:55 INFO - 'sessionrestore_no_auto_restore', 01:59:55 INFO - 'tabpaint']}, 01:59:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:59:55 INFO - 'tests': ['a11yr', 01:59:55 INFO - 'ts_paint', 01:59:55 INFO - 'tpaint', 01:59:55 INFO - 'sessionrestore', 01:59:55 INFO - 'sessionrestore_no_auto_restore', 01:59:55 INFO - 'tabpaint']}, 01:59:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:59:55 INFO - 'tests': ['a11yr', 01:59:55 INFO - 'ts_paint', 01:59:55 INFO - 'tpaint', 01:59:55 INFO - 'sessionrestore', 01:59:55 INFO - 'sessionrestore_no_auto_restore', 01:59:55 INFO - 'tabpaint']}, 01:59:55 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 01:59:55 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 01:59:55 INFO - 'bloom_basic_ref']}, 01:59:55 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 01:59:55 INFO - 'talos_options': ['--mitmproxy', 01:59:55 INFO - 'mitmproxy-recording-1.mp', 01:59:55 INFO - '--firstNonBlankPaint'], 01:59:55 INFO - 'tests': ['Quantum_1']}, 01:59:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:59:55 INFO - 'tests': ['tsvgx', 01:59:55 INFO - 'tsvgr_opacity', 01:59:55 INFO - 'tart', 01:59:55 INFO - 'tscrollx', 01:59:55 INFO - 'cart', 01:59:55 INFO - 'tsvg_static']}, 01:59:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:59:55 INFO - 'tsvgr_opacity', 01:59:55 INFO - 'tart', 01:59:55 INFO - 'tscrollx', 01:59:55 INFO - 'cart', 01:59:55 INFO - 'tsvg_static']}, 01:59:55 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 01:59:55 INFO - 'talos_options': ['--disable-e10s'], 01:59:55 INFO - 'tests': ['tp5o']}, 01:59:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:59:55 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 01:59:55 INFO - 'talos_options': ['--disable-e10s', 01:59:55 INFO - '--xperf_path', 01:59:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:59:55 INFO - 'tests': ['tp5n']}, 01:59:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:59:55 INFO - 'talos_options': ['--xperf_path', 01:59:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:59:55 INFO - 'tests': ['tp5n']}}, 01:59:55 INFO - 'talos.zip': {'path': '', 01:59:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:59:55 INFO - Running post-action listener: _resource_record_post_action 01:59:55 INFO - [mozharness: 2017-05-29 08:59:55.641857Z] Finished populate-webroot step (success) 01:59:55 INFO - [mozharness: 2017-05-29 08:59:55.641953Z] Running create-virtualenv step. 01:59:55 INFO - Running pre-action listener: _resource_record_pre_action 01:59:55 INFO - Running main action method: create_virtualenv 01:59:55 INFO - Creating virtualenv /builds/slave/test/build/venv 01:59:55 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 01:59:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:59:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:59:55 INFO - Using real prefix '/usr' 01:59:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:59:56 INFO - Installing distribute.............................................................................................................................................................................................done. 01:59:58 INFO - Installing pip.................done. 01:59:58 INFO - Return code: 0 01:59:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:59:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:59:58 INFO - Reading from file tmpfile_stdout 01:59:58 INFO - Output received: 01:59:58 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) 01:59:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:59:58 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')]} 01:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:59:58 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')]} 01:59:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:59:58 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 0xf323b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12afef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ace40>, '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 0x12adfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ae440>, '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': 'ea65d483da93c827905c2090000001f5-1496032186.124567-1132932723', '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 01:59:58 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 01:59:58 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 01:59:58 INFO - Using env: {'DISPLAY': ':0', 01:59:58 INFO - 'HOME': '/home/cltbld', 01:59:58 INFO - 'LANG': 'en_US.UTF-8', 01:59:58 INFO - 'LANGUAGE': 'en_US:en', 01:59:58 INFO - 'LOGNAME': 'cltbld', 01:59:58 INFO - 'MAIL': '/var/mail/cltbld', 01:59:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:59:58 INFO - 'MOZ_NO_REMOTE': '1', 01:59:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:59:58 INFO - 'NO_EM_RESTART': '1', 01:59:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:59:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:59:58 INFO - 'PWD': '/builds/slave/test', 01:59:58 INFO - 'SHELL': '/bin/bash', 01:59:58 INFO - 'SHLVL': '1', 01:59:58 INFO - 'TERM': 'linux', 01:59:58 INFO - 'TMOUT': '86400', 01:59:58 INFO - 'USER': 'cltbld', 01:59:58 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1496032186.124567-1132932723', 01:59:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:59:58 INFO - '_': '/tools/buildbot/bin/python'} 01:59:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:59:58 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 01:59:58 INFO - Cleaning up... 01:59:58 INFO - Return code: 0 01:59:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:59:58 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')]} 01:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:59:58 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')]} 01:59:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:59:58 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 0xf323b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12afef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ace40>, '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 0x12adfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ae440>, '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': 'ea65d483da93c827905c2090000001f5-1496032186.124567-1132932723', '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 01:59:58 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 01:59:58 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 01:59:58 INFO - Using env: {'DISPLAY': ':0', 01:59:58 INFO - 'HOME': '/home/cltbld', 01:59:58 INFO - 'LANG': 'en_US.UTF-8', 01:59:58 INFO - 'LANGUAGE': 'en_US:en', 01:59:58 INFO - 'LOGNAME': 'cltbld', 01:59:58 INFO - 'MAIL': '/var/mail/cltbld', 01:59:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:59:58 INFO - 'MOZ_NO_REMOTE': '1', 01:59:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:59:58 INFO - 'NO_EM_RESTART': '1', 01:59:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:59:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:59:58 INFO - 'PWD': '/builds/slave/test', 01:59:58 INFO - 'SHELL': '/bin/bash', 01:59:58 INFO - 'SHLVL': '1', 01:59:58 INFO - 'TERM': 'linux', 01:59:58 INFO - 'TMOUT': '86400', 01:59:58 INFO - 'USER': 'cltbld', 01:59:58 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1496032186.124567-1132932723', 01:59:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:59:58 INFO - '_': '/tools/buildbot/bin/python'} 01:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:59:59 INFO - Downloading/unpacking psutil>=3.1.1 01:59:59 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 01:59:59 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 01:59:59 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 01:59:59 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 02:00:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:00:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:00:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:00:01 INFO - Installing collected packages: psutil 02:00:01 INFO - Running setup.py install for psutil 02:00:01 INFO - building 'psutil._psutil_linux' extension 02:00:01 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 02:00:01 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 02:00:01 INFO - building 'psutil._psutil_posix' extension 02:00:01 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 02:00:02 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 02:00:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:00:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:00:02 INFO - Successfully installed psutil 02:00:02 INFO - Cleaning up... 02:00:02 INFO - Return code: 0 02:00:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:00: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')]} 02:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00: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')]} 02:00:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf323b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12afef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ace40>, '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 0x12adfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ae440>, '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': 'ea65d483da93c827905c2090000001f5-1496032186.124567-1132932723', '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 02:00:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:00:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:00:02 INFO - Using env: {'DISPLAY': ':0', 02:00:02 INFO - 'HOME': '/home/cltbld', 02:00:02 INFO - 'LANG': 'en_US.UTF-8', 02:00:02 INFO - 'LANGUAGE': 'en_US:en', 02:00:02 INFO - 'LOGNAME': 'cltbld', 02:00:02 INFO - 'MAIL': '/var/mail/cltbld', 02:00:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:02 INFO - 'MOZ_NO_REMOTE': '1', 02:00:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:02 INFO - 'NO_EM_RESTART': '1', 02:00:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:02 INFO - 'PWD': '/builds/slave/test', 02:00:02 INFO - 'SHELL': '/bin/bash', 02:00:02 INFO - 'SHLVL': '1', 02:00:02 INFO - 'TERM': 'linux', 02:00:02 INFO - 'TMOUT': '86400', 02:00:02 INFO - 'USER': 'cltbld', 02:00:02 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1496032186.124567-1132932723', 02:00:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:02 INFO - '_': '/tools/buildbot/bin/python'} 02:00:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:00:02 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 02:00:02 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 02:00:02 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 02:00:02 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 02:00:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:00:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:00:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:00:05 INFO - Installing collected packages: mozsystemmonitor 02:00:05 INFO - Running setup.py install for mozsystemmonitor 02:00:05 INFO - Successfully installed mozsystemmonitor 02:00:05 INFO - Cleaning up... 02:00:05 INFO - Return code: 0 02:00:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:00:05 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')]} 02:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:05 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')]} 02:00:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:05 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 0xf323b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12afef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ace40>, '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 0x12adfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ae440>, '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': 'ea65d483da93c827905c2090000001f5-1496032186.124567-1132932723', '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 02:00:05 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 02:00:05 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 02:00:05 INFO - Using env: {'DISPLAY': ':0', 02:00:05 INFO - 'HOME': '/home/cltbld', 02:00:05 INFO - 'LANG': 'en_US.UTF-8', 02:00:05 INFO - 'LANGUAGE': 'en_US:en', 02:00:05 INFO - 'LOGNAME': 'cltbld', 02:00:05 INFO - 'MAIL': '/var/mail/cltbld', 02:00:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:05 INFO - 'MOZ_NO_REMOTE': '1', 02:00:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:05 INFO - 'NO_EM_RESTART': '1', 02:00:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:05 INFO - 'PWD': '/builds/slave/test', 02:00:05 INFO - 'SHELL': '/bin/bash', 02:00:05 INFO - 'SHLVL': '1', 02:00:05 INFO - 'TERM': 'linux', 02:00:05 INFO - 'TMOUT': '86400', 02:00:05 INFO - 'USER': 'cltbld', 02:00:05 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1496032186.124567-1132932723', 02:00:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:05 INFO - '_': '/tools/buildbot/bin/python'} 02:00:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:05 INFO - Downloading/unpacking jsonschema==2.5.1 02:00:05 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 02:00:05 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 02:00:05 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 02:00:05 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 02:00:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:00:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:00: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 02:00: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 02:00: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 02:00: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 02:00:08 INFO - Downloading functools32-3.2.3-2.tar.gz 02:00:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:00:08 INFO - warning: no files found matching '*.txt' 02:00:08 INFO - no previously-included directories found matching 'build' 02:00:08 INFO - no previously-included directories found matching 'dist' 02:00:08 INFO - no previously-included directories found matching '.git*' 02:00:08 INFO - Installing collected packages: jsonschema, functools32 02:00:08 INFO - Running setup.py install for functools32 02:00:08 INFO - warning: no files found matching '*.txt' 02:00:08 INFO - no previously-included directories found matching 'build' 02:00:08 INFO - no previously-included directories found matching 'dist' 02:00:08 INFO - no previously-included directories found matching '.git*' 02:00:08 INFO - Successfully installed jsonschema functools32 02:00:08 INFO - Cleaning up... 02:00:08 INFO - Return code: 0 02:00:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:00: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')]} 02:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00: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')]} 02:00:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00: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', '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 0xf323b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12afef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ace40>, '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 0x12adfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ae440>, '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': 'ea65d483da93c827905c2090000001f5-1496032186.124567-1132932723', '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 02:00: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:00: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 functools32==3.2.3-2 02:00:08 INFO - Using env: {'DISPLAY': ':0', 02:00:08 INFO - 'HOME': '/home/cltbld', 02:00:08 INFO - 'LANG': 'en_US.UTF-8', 02:00:08 INFO - 'LANGUAGE': 'en_US:en', 02:00:08 INFO - 'LOGNAME': 'cltbld', 02:00:08 INFO - 'MAIL': '/var/mail/cltbld', 02:00:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:08 INFO - 'MOZ_NO_REMOTE': '1', 02:00:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:08 INFO - 'NO_EM_RESTART': '1', 02:00:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:08 INFO - 'PWD': '/builds/slave/test', 02:00:08 INFO - 'SHELL': '/bin/bash', 02:00:08 INFO - 'SHLVL': '1', 02:00:08 INFO - 'TERM': 'linux', 02:00:08 INFO - 'TMOUT': '86400', 02:00:08 INFO - 'USER': 'cltbld', 02:00:08 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1496032186.124567-1132932723', 02:00:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:08 INFO - '_': '/tools/buildbot/bin/python'} 02:00:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:00:08 INFO - Cleaning up... 02:00:08 INFO - Return code: 0 02:00:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:00: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')]} 02:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00: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')]} 02:00:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00: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', '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 0xf323b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12afef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ace40>, '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 0x12adfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ae440>, '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': 'ea65d483da93c827905c2090000001f5-1496032186.124567-1132932723', '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 02:00: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:00: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 blobuploader==1.2.4 02:00:08 INFO - Using env: {'DISPLAY': ':0', 02:00:08 INFO - 'HOME': '/home/cltbld', 02:00:08 INFO - 'LANG': 'en_US.UTF-8', 02:00:08 INFO - 'LANGUAGE': 'en_US:en', 02:00:08 INFO - 'LOGNAME': 'cltbld', 02:00:08 INFO - 'MAIL': '/var/mail/cltbld', 02:00:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:08 INFO - 'MOZ_NO_REMOTE': '1', 02:00:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:08 INFO - 'NO_EM_RESTART': '1', 02:00:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:08 INFO - 'PWD': '/builds/slave/test', 02:00:08 INFO - 'SHELL': '/bin/bash', 02:00:08 INFO - 'SHLVL': '1', 02:00:08 INFO - 'TERM': 'linux', 02:00:08 INFO - 'TMOUT': '86400', 02:00:08 INFO - 'USER': 'cltbld', 02:00:08 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1496032186.124567-1132932723', 02:00:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:08 INFO - '_': '/tools/buildbot/bin/python'} 02:00:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:09 INFO - Downloading/unpacking blobuploader==1.2.4 02:00:09 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 02:00:09 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 02:00:09 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 02:00:09 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 02:00:11 INFO - Downloading blobuploader-1.2.4.tar.gz 02:00:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:00:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:00: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 02:00: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 02:00: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 02:00: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 02:00:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:00:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:00: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 02:00: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 02:00: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 02:00: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 02:00:13 INFO - Downloading docopt-0.6.1.tar.gz 02:00:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:00:13 INFO - Installing collected packages: blobuploader, requests, docopt 02:00:13 INFO - Running setup.py install for blobuploader 02:00:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:00:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:00:13 INFO - Running setup.py install for requests 02:00:13 INFO - Running setup.py install for docopt 02:00:13 INFO - Successfully installed blobuploader requests docopt 02:00:13 INFO - Cleaning up... 02:00:13 INFO - Return code: 0 02:00:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:00:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:00:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00: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 0xf323b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12afef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ace40>, '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 0x12adfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ae440>, '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': 'ea65d483da93c827905c2090000001f5-1496032186.124567-1132932723', '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 02:00: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 02:00: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 02:00:14 INFO - Using env: {'DISPLAY': ':0', 02:00:14 INFO - 'HOME': '/home/cltbld', 02:00:14 INFO - 'LANG': 'en_US.UTF-8', 02:00:14 INFO - 'LANGUAGE': 'en_US:en', 02:00:14 INFO - 'LOGNAME': 'cltbld', 02:00:14 INFO - 'MAIL': '/var/mail/cltbld', 02:00:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:14 INFO - 'MOZ_NO_REMOTE': '1', 02:00:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:14 INFO - 'NO_EM_RESTART': '1', 02:00:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:14 INFO - 'PWD': '/builds/slave/test', 02:00:14 INFO - 'SHELL': '/bin/bash', 02:00:14 INFO - 'SHLVL': '1', 02:00:14 INFO - 'TERM': 'linux', 02:00:14 INFO - 'TMOUT': '86400', 02:00:14 INFO - 'USER': 'cltbld', 02:00:14 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1496032186.124567-1132932723', 02:00:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:14 INFO - '_': '/tools/buildbot/bin/python'} 02:00:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:00:14 INFO - Running setup.py (path:/tmp/pip-YmRpEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:00:14 INFO - Running setup.py (path:/tmp/pip-KccXPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:00:14 INFO - Running setup.py (path:/tmp/pip-_ZoRDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:00:14 INFO - Running setup.py (path:/tmp/pip-oAOwgw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:00:14 INFO - Running setup.py (path:/tmp/pip-kTHRov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:00:14 INFO - Running setup.py (path:/tmp/pip-q1Sj2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:00:14 INFO - Running setup.py (path:/tmp/pip-deqWV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:00:14 INFO - Running setup.py (path:/tmp/pip-IFbsKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:00:14 INFO - Running setup.py (path:/tmp/pip-An4F2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:00:14 INFO - Running setup.py (path:/tmp/pip-FxaGRK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:00:14 INFO - Running setup.py (path:/tmp/pip-ic00tV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:00:15 INFO - Running setup.py (path:/tmp/pip-hY4twt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:00:15 INFO - Running setup.py (path:/tmp/pip-tqdh2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:00:15 INFO - Running setup.py (path:/tmp/pip-f2o6bX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:00:15 INFO - Running setup.py (path:/tmp/pip-20o6_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:00:15 INFO - Running setup.py (path:/tmp/pip-Lr3_ya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:00:15 INFO - Running setup.py (path:/tmp/pip-bEtW8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:00:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:00:15 INFO - Running setup.py install for manifestparser 02:00:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:00:15 INFO - Running setup.py install for mozcrash 02:00:15 INFO - Running setup.py install for mozdebug 02:00:15 INFO - Running setup.py install for mozdevice 02:00:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:00:15 INFO - Running setup.py install for mozfile 02:00:15 INFO - Running setup.py install for mozhttpd 02:00:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:00:16 INFO - Running setup.py install for mozinfo 02:00:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:00:16 INFO - Running setup.py install for mozInstall 02:00:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:00:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:00:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:00:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:00:16 INFO - Running setup.py install for mozleak 02:00:16 INFO - Running setup.py install for mozlog 02:00:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:00:16 INFO - Running setup.py install for moznetwork 02:00:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:00:16 INFO - Running setup.py install for mozprocess 02:00:16 INFO - Running setup.py install for mozprofile 02:00:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:00:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:00:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:00:16 INFO - Running setup.py install for mozrunner 02:00:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:00:16 INFO - Running setup.py install for mozscreenshot 02:00:16 INFO - Running setup.py install for moztest 02:00:17 INFO - Running setup.py install for mozversion 02:00:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:00:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:00:17 INFO - Cleaning up... 02:00:17 INFO - Return code: 0 02:00:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:00: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')]} 02:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00: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')]} 02:00:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00: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 0xf323b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12afef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ace40>, '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 0x12adfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ae440>, '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': 'ea65d483da93c827905c2090000001f5-1496032186.124567-1132932723', '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 02:00: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 02:00: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 02:00:17 INFO - Using env: {'DISPLAY': ':0', 02:00:17 INFO - 'HOME': '/home/cltbld', 02:00:17 INFO - 'LANG': 'en_US.UTF-8', 02:00:17 INFO - 'LANGUAGE': 'en_US:en', 02:00:17 INFO - 'LOGNAME': 'cltbld', 02:00:17 INFO - 'MAIL': '/var/mail/cltbld', 02:00:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:17 INFO - 'MOZ_NO_REMOTE': '1', 02:00:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:17 INFO - 'NO_EM_RESTART': '1', 02:00:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:17 INFO - 'PWD': '/builds/slave/test', 02:00:17 INFO - 'SHELL': '/bin/bash', 02:00:17 INFO - 'SHLVL': '1', 02:00:17 INFO - 'TERM': 'linux', 02:00:17 INFO - 'TMOUT': '86400', 02:00:17 INFO - 'USER': 'cltbld', 02:00:17 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1496032186.124567-1132932723', 02:00:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:17 INFO - '_': '/tools/buildbot/bin/python'} 02:00:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:00:17 INFO - Running setup.py (path:/tmp/pip-3X6KND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:00: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)) 02:00:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:00:17 INFO - Running setup.py (path:/tmp/pip-Z3chLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:00: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)) 02:00:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:00:17 INFO - Running setup.py (path:/tmp/pip-RrJYTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:00:17 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)) 02:00:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:00:17 INFO - Running setup.py (path:/tmp/pip-KytP98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:00:17 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)) 02:00:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:00:17 INFO - Running setup.py (path:/tmp/pip-qqzIJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:00:17 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)) 02:00:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:00:17 INFO - Running setup.py (path:/tmp/pip-_kKzUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:00:17 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)) 02:00:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:00:17 INFO - Running setup.py (path:/tmp/pip-NVwYMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:00:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 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)) 02:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:00:18 INFO - Running setup.py (path:/tmp/pip-no1vp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:00:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 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)) 02:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:00:18 INFO - Running setup.py (path:/tmp/pip-4FD6ud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:00: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)) 02:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:00:18 INFO - Running setup.py (path:/tmp/pip-b2CYNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:00:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 02:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:00:18 INFO - Running setup.py (path:/tmp/pip-LURMgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:00: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)) 02:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:00:18 INFO - Running setup.py (path:/tmp/pip-s9Q_Gc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:00: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)) 02:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:00:18 INFO - Running setup.py (path:/tmp/pip-93bJF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:00: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)) 02:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:00:18 INFO - Running setup.py (path:/tmp/pip-ys33wE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:00: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)) 02:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:00:18 INFO - Running setup.py (path:/tmp/pip-gQUmSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:00: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)) 02:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:00:18 INFO - Running setup.py (path:/tmp/pip-W3c3WA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:00: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)) 02:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:00:18 INFO - Running setup.py (path:/tmp/pip-MbCoNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:00:18 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)) 02:00:18 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)) 02:00:18 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)) 02:00:18 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)) 02:00:18 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)) 02:00:18 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)) 02:00:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:19 INFO - Downloading blessings-1.6.tar.gz 02:00:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:00:20 INFO - Installing collected packages: blessings 02:00:20 INFO - Running setup.py install for blessings 02:00:20 INFO - Successfully installed blessings 02:00:20 INFO - Cleaning up... 02:00:20 INFO - Return code: 0 02:00:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:00:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:00:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:00:20 INFO - Reading from file tmpfile_stdout 02:00:20 INFO - Current package versions: 02:00:20 INFO - argparse == 1.2.1 02:00:20 INFO - blessings == 1.6 02:00:20 INFO - blobuploader == 1.2.4 02:00:20 INFO - docopt == 0.6.1 02:00:20 INFO - functools32 == 3.2.3-2 02:00:20 INFO - jsonschema == 2.5.1 02:00:20 INFO - manifestparser == 1.1 02:00:20 INFO - mozInstall == 1.12 02:00:20 INFO - mozcrash == 1.0 02:00:20 INFO - mozdebug == 0.1 02:00:20 INFO - mozdevice == 0.51 02:00:20 INFO - mozfile == 1.2 02:00:20 INFO - mozhttpd == 0.7 02:00:20 INFO - mozinfo == 0.9 02:00:20 INFO - mozleak == 0.1 02:00:20 INFO - mozlog == 3.4 02:00:20 INFO - moznetwork == 0.27 02:00:20 INFO - mozprocess == 0.25 02:00:20 INFO - mozprofile == 0.28 02:00:20 INFO - mozrunner == 6.13 02:00:20 INFO - mozscreenshot == 0.1 02:00:20 INFO - mozsystemmonitor == 0.3 02:00:20 INFO - moztest == 0.8 02:00:20 INFO - mozversion == 1.4 02:00:20 INFO - psutil == 3.1.1 02:00:20 INFO - requests == 1.2.3 02:00:20 INFO - wsgiref == 0.1.2 02:00:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:00: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')]} 02:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00: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')]} 02:00:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00: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 0xf323b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12afef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ace40>, '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 0x12adfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ae440>, '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': 'ea65d483da93c827905c2090000001f5-1496032186.124567-1132932723', '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 02:00: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 02:00: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 02:00:20 INFO - Using env: {'DISPLAY': ':0', 02:00:20 INFO - 'HOME': '/home/cltbld', 02:00:20 INFO - 'LANG': 'en_US.UTF-8', 02:00:20 INFO - 'LANGUAGE': 'en_US:en', 02:00:20 INFO - 'LOGNAME': 'cltbld', 02:00:20 INFO - 'MAIL': '/var/mail/cltbld', 02:00:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:20 INFO - 'MOZ_NO_REMOTE': '1', 02:00:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:20 INFO - 'NO_EM_RESTART': '1', 02:00:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:20 INFO - 'PWD': '/builds/slave/test', 02:00:20 INFO - 'SHELL': '/bin/bash', 02:00:20 INFO - 'SHLVL': '1', 02:00:20 INFO - 'TERM': 'linux', 02:00:20 INFO - 'TMOUT': '86400', 02:00:20 INFO - 'USER': 'cltbld', 02:00:20 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1496032186.124567-1132932723', 02:00:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:20 INFO - '_': '/tools/buildbot/bin/python'} 02:00:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00: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)) 02:00: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)) 02:00: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)) 02:00: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)) 02:00: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)) 02:00: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)) 02:00: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)) 02:00: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)) 02:00: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)) 02:00:20 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:00: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 02:00: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 02:00: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 02:00: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 02:00:22 INFO - Downloading marionette_driver-1.4.0.tar.gz 02:00:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 02:00: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)) 02:00: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)) 02:00: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)) 02:00: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)) 02:00:22 INFO - Installing collected packages: marionette-driver 02:00:22 INFO - Running setup.py install for marionette-driver 02:00:23 INFO - Successfully installed marionette-driver 02:00:23 INFO - Cleaning up... 02:00:23 INFO - Return code: 0 02:00:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:00: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')]} 02:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00: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')]} 02:00:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00: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 0xf323b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12afef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ace40>, '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 0x12adfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ae440>, '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': 'ea65d483da93c827905c2090000001f5-1496032186.124567-1132932723', '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 02:00: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 02:00: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 02:00:23 INFO - Using env: {'DISPLAY': ':0', 02:00:23 INFO - 'HOME': '/home/cltbld', 02:00:23 INFO - 'LANG': 'en_US.UTF-8', 02:00:23 INFO - 'LANGUAGE': 'en_US:en', 02:00:23 INFO - 'LOGNAME': 'cltbld', 02:00:23 INFO - 'MAIL': '/var/mail/cltbld', 02:00:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:23 INFO - 'MOZ_NO_REMOTE': '1', 02:00:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:23 INFO - 'NO_EM_RESTART': '1', 02:00:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:23 INFO - 'PWD': '/builds/slave/test', 02:00:23 INFO - 'SHELL': '/bin/bash', 02:00:23 INFO - 'SHLVL': '1', 02:00:23 INFO - 'TERM': 'linux', 02:00:23 INFO - 'TMOUT': '86400', 02:00:23 INFO - 'USER': 'cltbld', 02:00:23 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1496032186.124567-1132932723', 02:00:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:23 INFO - '_': '/tools/buildbot/bin/python'} 02:00:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:00:23 INFO - Cleaning up... 02:00:23 INFO - Return code: 0 02:00:23 INFO - Running post-action listener: _resource_record_post_action 02:00:23 INFO - Running post-action listener: _start_resource_monitoring 02:00:23 INFO - Starting resource monitoring. 02:00:23 INFO - [mozharness: 2017-05-29 09:00:23.314296Z] Finished create-virtualenv step (success) 02:00:23 INFO - [mozharness: 2017-05-29 09:00:23.314773Z] Running install step. 02:00:23 INFO - Running pre-action listener: _resource_record_pre_action 02:00:23 INFO - Running main action method: install 02:00:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:00:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:00:23 INFO - Reading from file tmpfile_stdout 02:00:23 INFO - Detecting whether we're running mozinstall >=1.0... 02:00:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:00:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:00:23 INFO - Reading from file tmpfile_stdout 02:00:23 INFO - Output received: 02:00:23 INFO - Usage: mozinstall [options] installer 02:00:23 INFO - Options: 02:00:23 INFO - -h, --help show this help message and exit 02:00:23 INFO - -d DEST, --destination=DEST 02:00:23 INFO - Directory to install application into. [default: 02:00:23 INFO - "/builds/slave/test"] 02:00:23 INFO - --app=APP Application being installed. [default: firefox] 02:00:23 INFO - mkdir: /builds/slave/test/build/application 02:00: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'] 02:00:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:00:39 INFO - Reading from file tmpfile_stdout 02:00:39 INFO - Output received: 02:00:39 INFO - /builds/slave/test/build/application/firefox/firefox 02:00:39 INFO - Running post-action listener: _resource_record_post_action 02:00:39 INFO - [mozharness: 2017-05-29 09:00:39.144695Z] Finished install step (success) 02:00:39 INFO - [mozharness: 2017-05-29 09:00:39.144971Z] Running setup-mitmproxy step. 02:00:39 INFO - Running pre-action listener: _resource_record_pre_action 02:00:39 INFO - Running main action method: setup_mitmproxy 02:00:39 INFO - Skipping: mitmproxy is not required 02:00:39 INFO - Running post-action listener: _resource_record_post_action 02:00:39 INFO - [mozharness: 2017-05-29 09:00:39.146079Z] Finished setup-mitmproxy step (success) 02:00:39 INFO - [mozharness: 2017-05-29 09:00:39.146298Z] Running run-tests step. 02:00:39 INFO - Running pre-action listener: _resource_record_pre_action 02:00:39 INFO - Running main action method: run_tests 02:00:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:00:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:00:39 INFO - Python 2.7.3 02:00:39 INFO - Return code: 0 02:00:39 INFO - grabbing minidump binary from tooltool 02:00:39 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')]} 02:00:39 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 0x12ace40>, '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 0x12adfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ae440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:00:39 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 02:00:39 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 02:00:39 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 02:00:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:00:39 INFO - Return code: 0 02:00:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:00:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:00:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:00:39 INFO - ENV: RUST_BACKTRACE is now 1 02:00:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:00:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:00:39 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/TddXRzz_SvuOenppX06GOQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-084', '--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 02:00:39 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/TddXRzz_SvuOenppX06GOQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-084 --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 02:00:39 INFO - Using env: {'DISPLAY': ':0', 02:00:39 INFO - 'HOME': '/home/cltbld', 02:00:39 INFO - 'LANG': 'en_US.UTF-8', 02:00:39 INFO - 'LANGUAGE': 'en_US:en', 02:00:39 INFO - 'LOGNAME': 'cltbld', 02:00:39 INFO - 'MAIL': '/var/mail/cltbld', 02:00:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:00:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:00:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:39 INFO - 'MOZ_NO_REMOTE': '1', 02:00:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:00:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:39 INFO - 'NO_EM_RESTART': '1', 02:00:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:39 INFO - 'PWD': '/builds/slave/test', 02:00:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:00:39 INFO - 'RUST_BACKTRACE': '1', 02:00:39 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:00:39 INFO - 'SHELL': '/bin/bash', 02:00:39 INFO - 'SHLVL': '1', 02:00:39 INFO - 'TERM': 'linux', 02:00:39 INFO - 'TMOUT': '86400', 02:00:39 INFO - 'USER': 'cltbld', 02:00:39 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1496032186.124567-1132932723', 02:00:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:39 INFO - '_': '/tools/buildbot/bin/python'} 02:00:39 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/TddXRzz_SvuOenppX06GOQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-084', '--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 02:00:39 INFO - mozversion application_buildid: 20170529082334 02:00:39 INFO - mozversion application_changeset: cce4d83d2b99ffedbd67a2f40ce26e53e9ae27ab 02:00:39 INFO - mozversion application_display_name: Nightly 02:00:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:00:39 INFO - mozversion application_name: Firefox 02:00:39 INFO - mozversion application_remotingname: firefox 02:00:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:00:39 INFO - mozversion application_vendor: Mozilla 02:00:39 INFO - mozversion application_version: 55.0a1 02:00:39 INFO - mozversion platform_buildid: 20170529082334 02:00:39 INFO - mozversion platform_changeset: cce4d83d2b99ffedbd67a2f40ce26e53e9ae27ab 02:00:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:00:39 INFO - mozversion platform_version: 55.0a1 02:00:39 INFO - using testdate: 1496048439 02:00:39 INFO - actual date: 1496048439 02:00:39 INFO - starting webserver on 'localhost:58942' 02:00:39 INFO - SUITE-START | Running 2 tests 02:00:39 INFO - TEST-START | dromaeo_css 02:00:39 INFO - operating with platform_type : linux_ 02:00:39 INFO - Initialising browser for dromaeo_css test... 02:00:39 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58942/getInfo.html -profile /tmp/tmpaIxY5A/profile 02:00:39 INFO - TEST-INFO | started process 4221 (/builds/slave/test/build/application/firefox/firefox http://localhost:58942/getInfo.html) 02:01:14 INFO - TEST-INFO | 4221: killed by SIGTERM 02:01:14 INFO - Browser initialized. 02:01:14 INFO - Running cycle 1/1 for dromaeo_css test... 02:01:14 INFO - TEST-INFO | started process 4418 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaIxY5A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:01:26 INFO - PID 4418 | RSS: Main: 182128640 02:01:26 INFO - PID 4418 | 02:04:32 INFO - PID 4418 | Cycle 1(1): loaded http://localhost:58942/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58942/tests/dromaeo/cssquery-ext.html) 02:04:34 INFO - PID 4418 | RSS: Main: 179765248 02:04:34 INFO - PID 4418 | 02:07:35 INFO - PID 4418 | Cycle 1(1): loaded http://localhost:58942/tests/dromaeo/cssquery-ext.html (next: http://localhost:58942/tests/dromaeo/cssquery-jquery.html) 02:07:36 INFO - PID 4418 | RSS: Main: 183074816 02:07:36 INFO - PID 4418 | 02:10:38 INFO - PID 4418 | Cycle 1(1): loaded http://localhost:58942/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58942/tests/dromaeo/cssquery-mootools.html) 02:10:38 INFO - PID 4418 | RSS: Main: 180584448 02:10:38 INFO - PID 4418 | 02:13:40 INFO - PID 4418 | Cycle 1(1): loaded http://localhost:58942/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58942/tests/dromaeo/cssquery-prototype.html) 02:13:41 INFO - PID 4418 | RSS: Main: 184811520 02:13:41 INFO - PID 4418 | 02:16:44 INFO - PID 4418 | Cycle 1(1): loaded http://localhost:58942/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58942/tests/dromaeo/cssquery-yui.html) 02:16:44 INFO - PID 4418 | RSS: Main: 185180160 02:16:44 INFO - PID 4418 | 02:19:46 INFO - PID 4418 | Cycle 1(1): loaded http://localhost:58942/tests/dromaeo/cssquery-yui.html (next: http://localhost:58942/tests/dromaeo/cssquery-dojo.html) 02:19:46 INFO - PID 4418 | RSS: Main: 182640640 02:19:46 INFO - PID 4418 | 02:19:46 INFO - PID 4418 | __start_tp_report 02:19:46 INFO - PID 4418 | _x_x_mozilla_page_load 02:19:46 INFO - PID 4418 | _x_x_mozilla_page_load_details 02:19:46 INFO - PID 4418 | |i|pagename|runs| 02:19:46 INFO - PID 4418 | |0;dojo.html;2737.603047558104;2752.2568906395263;2761.654793150856;2786.749192572668;2788.1914244869004;5178.66338687985;5253.763580638875;5278.917821846522;5288.8413347599635;5322.201669749539;5278.762455689493;5293.338332708411;5302.3106996090555;5387.703676297802;5399.19012148178;4473.731576105444;4677.88305292367;4727.409073865767;4734;4763.166445871959;4787.257975013861;4802.35168252285;4825.7587120644;4832.1543729847135;4851.927221091669;4653.348531205634;4698.365720627706;4711.976440117777;4754.191787396151;4773.11697335994;4670.206064968964;4698.553637404441;4720.197566413718;4731.408573928259;4745.501722319142;4672.509386514401;4697.295405689139;4731.2430011198385;4734.147853386389;4747;5263.105272103713;5289.3917199521775;5311.787528498855;5322.7072511011875;5360.678359298455;5596.2165296858475;5616.606837521375;5675.432456754333;5682.801101961411;5700.515456186229;5794.246747922785;5794.768209271624;5797.681127537984;5802.767889284423;5869.589128760988;5343.305370301913;5355.946440535545;5376.758045887945;5379.273798037215;5381.515663590218;5704.743286552115;5757.13642953552;5809.24479817621;5888.499477544457;5909.970450147808;5639.436056394327;5653.745581448845;5669.574781891292;5670.319561652628;5703.914441283384;5733.8566535836935;5745.712714364265;5756.5682573807135;5760.74076666551;5764.971175144097;5572.888542229132;5606.6916319602815;5647.858803529944;5729.684867332337;5737.655740655574;5614.9157762633595;5638.774449022075;5688.687122208235;5688.943110568925;5717.828465146053;4764.618830493621;4770.76146192689;4771.5228477152705;4803.255495398219;4806.44725856524;4101.753894766323;4106.67146628269;4116.361963895601;4122.093139509303;4150.460440142762;4710.364100846342;4728.976355118271;4742.834000809955;4776.832810851603;4827.565519103297;5741.282339707536;5752.539796816244;5755.65466072037;5829.242198514166;5846.1230815377185;4812.831550895772;4846.75766211688;4850.1269771440775;4850.369451971292;4867.902641947212;4826.203676393356;4905.0189962007025;5023.572996295283;5031.823886163967;5041.949580504222;5245.239440281214;5321;5341.038613049688;5342.011727830364;5345.572354211731;5625.606207565431;5636.239107720406;5654.6889921054735;5689.914651280317;5725.7137143141845;5202.24567437727;5314;5348.679079255257;5376.973115134399;5382.30030096085;5607.186957891165;5614.410486898817;5614.943850561442;5639.182318563703;5643.83068507929;5613.326400831927;5719.742611582572;5741.483266506035;5762.596618236683;5792.5655575832825;5582.3859375467855;5594.636348637326;5598.10430331145;5609.6073274872;5637.689927054052;5502.661368918274;5585;5588.217649529151;5591.8881622368135;5592.636478628876;5337.733113344239;5417.052015897123;5422.701751403552;5497.422770609029;5574.080276754452;5654;5665.3201615806365;5674.120511320752;5696.601237913472;5703.287089113861;5412.052890744183;5463.863403414946;5464.344278686424;5465.6447330923365;5471.8084867029465 02:19:46 INFO - PID 4418 | |1;ext.html;706.448969803553;743.5315751076822;764.5833021003551;1083.0956151613398;1104.1718710966775;31779.841100794492;33580;33585.32829343412;33701;33732.662673373256;34723;35207.295854082906;35220;35233;35240.64759352406;6522.706478208492;6698.263191049005;6856.82857928552;6976.162860456752;6977.686004129801;6690.7323707051655;6728.629925354104;6794.184697836242;6814.182298124232;6814.352636499525;6732.360425759545;6768.153980752406;6785.932140678604;6795.252522222551;6824.590524568542;6759.526833121683;6785.59286442815;6788.558743681694;6797.116374871284;6805.081314022643;6611.537192396486;6655.600663960129;6660.800175994728;6685.598864068172;6686.331366863324;31399;31409;31413.37173256522;31526.36947261042;31538.36923261545;3069.570260163579;3097.1792474994145;3119.1110533497845;3119.2357872321427;3136.52952057191;24734.505309893702;24804.751952480423;24879.62680559793;24929.50140997188;24992.875035624886;2895.753860921824;2984.4180384824967;3025.243689077731;3045.710657487535;3055.6027716396948;122171.3891430546;123676;132646.3367683165;141138.88291675632;142368;38570.421443678366;38821.41767873484;38854.22291554153;38945.80527097346;38989.415158772645;40311.59688403078;40385.59614403877;40460.39309410361;40540.594594053684;40549;12154.87845121555;12204.328761918003;12221.69445763863;12265.57070502546;12313.815292770616;9805.754856128511;9816.821981362282;9850.064243896819;9876.950615246878;9880.604775808888;12627.873721262853;12638;12666;12695.619131426072;12773.744525109445;5246.895062098813;5359.571234301325;5369.140937450067;5377.8117765878005;5412.512873841373;857.511218605389;906.1346414174448;907.5598334807613;925.7731855695398;944.7496413450441;19871.51606049244;20912.581748365254;20979.160833566486;21012.579748404947;21289.36131916045;968.4625033106553;975.3026585990908;979.3829887171037;986.4820968991194;1004.2016596805557;10764.192685548614;10991.450427478754;11100;11177.49701263445;11235;164117;164957;165353;165624;165700.17149914172;39671.60328396679;40016.79991600024;40031.199376012315;40090.79954600208;40107.799461003095;1181.1769966994989;1225.9816102758466;1235.5922545559943;1238.3313010973973;1238.6284114765535;19240.518987024876;19804.306849260207;20565.38303850887;20577.89711051495;20980.475488112308;28549;28828.711712882603;28874.42251154923;28913.56629650515;28929.710702893542;139938;140364;140775.29612351872;141386;142022;22318.330450086523;22596.774032260124;24766.38084047913;28094.71905280921;28234.2941426466;29138;29789.851050744608;30136.698633013388;30437.391252174388;30840.383192336478;23624.52750944937;23906.40233994164;24236.63645045361;24496.632550512113;24818;23576;23602.055917763097;23620.409489762893;23767.286981390585;23796.048158074176;26193.73806261913;26259;26271;26302.60546091772;26355.4728905417;22281.331560053226;22745.545089098458;23103.53792924166;23416.180433684738;27294.31764205831;19268.4219473416;22057.558848823253;22091.55816883621;22131.889340553837;22220.888895555418 02:19:46 INFO - PID 4418 | |2;jquery.html;401.72281126023023;410.65299821650694;428.209952637384;432.431352771106;440.9470863496381;11761.20528054113;13410.530631427902;17247.568810779736;17978.91010544947;18019.81980180198;13880.30598470075;17363.131843407842;17422;17478.912605436988;17503.212355444004;5207.375114986197;5414.1608050752;5431.34823821142;5445.918311225335;5471.288732464774;5154.355705536808;5333.4399888011785;5374.408815030363;5398.649087809299;5502.724863756816;5288.947110528884;5304.867378315535;5306.655067420625;5314.362276526803;5317.521423071923;5127.230915362688;5161.587073034167;5264.315638966929;5290.60320475962;5297.17893726473;4804.495527969548;4807.975960120212;4810.326554282403;4814.951850481485;4831.323614693945;20436;20583.38249852492;20785.16859325625;20872.895635521876;20893.791062089487;1596.2338077722643;1651.5293141454747;1662.6840900228917;1663.4178037686834;1664.45905080848;14065;14250;14382.065165764192;14487;14496;1988.1749074134218;2012.818846303825;2023.7976202379791;2029.0362078012972;2033.6644453665128;90287.54856225676;91484;92067.53966230193;92824.53587732086;93744.53127734318;10623.89376106229;10836.133109351233;10999.670009899715;11153.72115697114;11191.216614837045;14885.255737213312;15416.691666166838;15529.922350388175;15557.14435706047;15605.297761600528;6902.378785909293;7028.156621205488;7127.144742630918;7178.318059784312;7256.492045556761;6291.6854157291955;6320.683965801783;6447.25856526496;6492.156019717407;6524.282328943812;6717.227518835299;6913.412359949461;6960.965195173992;6983.615901125385;7154.534955227893;2060.47457898238;2067.12147337381;2077.8649387789746;2104.1793700456833;2229.308914236592;827.9586020699062;854.0562678240578;878.5168157513342;879.3580686099183;887.4276091920675;16212.432564860173;16254.800675456914;16450.75323870119;16678.49964501067;16781.328746849988;851.5997481183833;853.701204578405;862.9827403451895;869.604330029835;886.2644005475569;9041.23149532297;9050;9240.8613870792;9279.721608351625;9382.155605995493;353739;354852;356576;356763;363757;75655.62172189103;77105;77578.61210693911;77607;78219.60890195513;992.4690290694443;995.4723996281982;1015.9238057145743;1016.5120742043861;1029.6499190275342;13705.246211458465;14045.789313160107;14164.504242351468;14167.291635418394;14680.41278348854;37174.628253717114;37581;38071;38344.80827595844;39186;47924.28113578369;47987.520124798306;49438;49466.50533494619;50798.23802643037;7535.54786712799;7635.23647635232;7745.922540774745;7752.689892404241;8103.513789172668;12264.938675306923;12373.566925157576;12405.937970310451;12741.872581274069;13086.345682716017;10400.375977441076;11143.442827858737;11186;11232.943835280772;11750.29498230109;10308.845367319645;10561.366318020944;10583.94708026455;10605.363678179334;10690.41202733826;11366;11436.485358159069;11519.712007199552;11544.480498377425;11736.295822250693;7716.922830771845;7971.481853679492;8028.4781489203015;8102.635381407733;8160.755177344689;10926.836097458703;11006.229563930448;11128.276662016942;11220.270682405617;11285.21003529745 02:19:46 INFO - PID 4418 | |3;mootools.html;1244.7634949359622;1287.5043108403263;1295.3134838535573;1295.4300107952497;1304.6738315421144;10371.585136594536;10913.290636108648;10917.126629869612;10952.616658416957;11323.32060076396;10971.945140274307;11143;11183.944080279587;11193.72015699608;11194.66416007521;2195.5279614882797;2219.8113160381386;2236.3291012696127;2237.5748607764554;2240.1263507232193;2198.912043518257;2238.328501449567;2243.8317126215516;2246.528229071897;2250.9887450562724;2126.5959467701164;2151.107290474459;2162.221600223926;2171.9891400543056;2176.042541281831;2134.125008746414;2138.3905586907813;2145.6888751131078;2149.6668016457475;2150.903209355583;1884.3028079610494;1953.4139758072522;2068.389825001628;2132.616129096762;2158.2338269914267;10696.732581685443;10780.676579702544;10793.514291856885;10797.190210734227;10797.29817561856;5608.6073974821775;5851.268591426072;5872.823815285506;5880.26496687914;5900.881982360372;3215.614126304835;3338.7996720196866;3388.7289016878835;3398;3402.931941361184;1025.7743296474764;1039.8076355874111;1062.2564205056415;1087.1846115413439;1108.1467270201979;15869;15884.444044458503;15962.521124366287;16065.277062532214;16090.195490225442;4711.717296962193;4775.71345719258;4948.554630083309;4969.602431805447;4975.328330675385;11454.94272528632;11457.083433325313;11485.368304743319;11485.712857178638;11490.310581365145;5586.608937374344;5715;5715.199872017921;5723.456271654186;5725.112607545837;5083.364579427572;5222.843314700565;5234.057869583511;5257.4742525747115;5258;4277.529471758104;4335.458067741532;4382.605565499057;4456.799444025027;4472.932906006413;1301.711305807263;1342.9597112086653;1366.7744822104241;1373.3819781098546;1379.4413262628652;705.1608585782902;722.4689852958072;727.8216836874999;738.3391864281438;747.6672880568203;5688.288963879515;5772.884542309131;5778.27771528559;5804.854878628068;5908.793192238251;554.1964151979646;567.6677900722784;571.0349509329303;575.8502789274735;578.6412424296963;3751.8311675974646;4120.1553681495225;4129;4179.540250572434;4244;13101.41043653038;13732.725345493034;14127.364268607731;14146.575602731935;14162.71674566503;13642.93178534101;13970.231637259845;14112.364943577564;14166.150030998173;14284.642883927985;7657.387409007378;7741.922580774233;7788.337991270692;7856.135825059239;7874.803129921798;6034.366391529002;6173.81478555644;6200.844978875564;6210.658413787285;6294.213223347082;12463.875361246271;12556.246625202517;12639.620811375673;12829.93585032069;12887.871121288666;12894;12913.354332283161;12921.676958075746;13009.934950325187;13078.738425231251;8483.830323393375;8578.013528444058;8586.270167035871;8591.140885911358;8596.269317108116;9799.902000980184;9977.900220997697;9979.850302245326;10021.749456263651;10049.89950100519;8271.090180080066;8307.501549907025;8333.583320834055;8387.412881098264;8429.704960326359;8222.547759873265;8243.464174828618;8355.582220889053;8415.410921235454;8428.704995325133;7785.338246249133;7807;7849.686012559434;7854.882176767467;7874.251946065115;4821.710697358169;5480.753366098615;5539.307586551681;5548.722563871871;5626.718664066862;5473.917891231555;5680;5683.261176047087;5752.223449834219;5766.048601980794 02:19:46 INFO - PID 4418 | |4;prototype.html;387.6259409669668;393.2057244366379;393.67521794519513;393.80113042913325;396.74806497873857;5430.456954304573;5445.401005889354;5455.754491047903;5471.316085489314;5482.314710661168;5185.325907632003;5299.947000529994;5314.282571852798;5331.494197727072;5336.493033161853;4223.176480586287;4229.489523695341;4237.046664500478;4238.109996900655;4239.3852891330735;4191.937120943188;4218.704690671654;4225.746455212682;4233.470816147981;4234.724742891717;3945.5857135000842;4105.50733911931;4177;4189.455370801791;4215.620594146526;4117.2177286315655;4123.402106694542;4124.855630052949;4132.690048246393;4133.4626498555;3576.9642303576893;3587.641235876418;3611.043073585502;3615.096225943514;3625.873094441682;5189.195674670432;5297.735113244361;5314.60140489461;5317.54800841925;5343.572514198893;4767;4832.540908613676;4856.708597484162;4859.611231101503;4863.540937718705;5712.600117991742;5719.971400143014;5721.828345149652;5721.828345149652;5731.426857314277;3873.341531939549;4058.797060146981;4060.5736397678115;4069.433268191738;4085.22380747657;5933.9406605934255;5968.1942937703725;6064.545159113084;6069.453749162597;6122.510199184099;4542.11428771393;4564.3838081859185;4591.265397536378;4593.839215627437;4610.76946152691;4665.86002419928;4667.32323813052;4670.660477758419;4672.836450724209;4687.10944920464;5014.044522636174;5101.795928162832;5118.820841270612;5125.256837758504;5130.666506677128;5779.33537643168;5814.534837213013;5814.76740930358;5834.124881267844;5837.766489340379;1600.0479714569813;1614.9515514534583;1618.1747308872325;1618.6358069434518;1620.7811945387457;1142.9371384573928;1156.6414411532285;1161.7444162284285;1162.7965106106396;1176.5587904535798;4938.456769755324;4992.72540010303;4993.251012348177;5004.299398084271;5017.096922553902;5973.253343332083;5978.611390259706;5982.982892908216;5987.64074155552;6000.729967151488;4848.539388758062;4937.21004639256;4944.307796908363;4968.90062198754;4990.700557966534;3154.511050787132;3158.3999040182753;3171.7154552406314;3184.8407579620925;3192.664770199142;5447.494152689728;5534.916976245359;5546.112621980464;5597.160425936142;5607.607467477319;6095.933211687937;6111.694415279308;6165.691715414211;6172.105044768573;6181.474574661204;5566.666000040011;5569.081101618269;5587.022271102541;5619.831405057855;5625.831225063254;5785.132230165341;5885.764569417347;5915.349311575809;5945.821625351246;5962.731677074456;5814.680192589448;5841;5873.647581145145;5887.145549152004;5893.320403684929;5354.437784032621;5544.972275138599;5547.362053363753;5591;5595.188697638901;4056.1076563156057;4114.177164567159;4123.402106694452;4134.524529679125;4145.564715704808;6005.969970150121;6025.78909738157;6027.969860150672;6042.1843051187525;6042.758289668364;5800.9419905800405;5819.632386389279;5822;5834.986929509312;5835.503982161564;5671.546276297804;5782.855428614318;5832.854178645568;5834.241548598655;5842.561807864342;5736.168255602831;5749.942500574941;5750.194972703908;5768.278965129359;5773.971130144322;5646.435356464485;5793.739281732416;5853;5853.736581853912;5901.645901245939;5621.67131308898;5627.352854421794;5638.407967163553;5639.097744360883;5645.943540564706 02:19:46 INFO - PID 4418 | |5;yui.html;718.604767377942;748.128430378609;752.5146280648978;755.1881727143322;779.177967244557;12202;12509.061820363464;13227.669308267286;14068.859311406883;14157.45165870143;15072;15636.609084772886;15657.608559786011;15672.138032408213;15684.294206760695;809.6194788449434;821.4619424277108;825.8141918068417;829.4608504472081;833.1377024779355;864.0754392799707;864.5893200729635;864.9654013839439;865.7056600755742;866.6663334616155;903.2322525853006;904.5115637555712;906.207068814787;913.3789023464075;914.3051281026401;903.1104362203224;911.48956584313;921.0835218957113;921.4471317209687;922.8661844032578;656.1011414362354;667.3993405934649;673.0879658063303;678.4809620640215;678.9524733268673;13148.53980110701;13333.866661333359;13365.33173341329;13400.664983375493;13450.327483625779;14485.637859053502;14902.776458353133;15000.699986000329;15000.774988375184;15096.320665570076;12334.629961101182;12577.559785407559;12670.683232919158;12701.618951431472;12926.15979961309;2998.4602771501122;3007.6541197762317;3013.246688327918;3013.547967804847;3016.577679124924;74245;75674.24325756727;76838.84741728935;77359.61320193364;83491;12260;12264.754704905852;12418.565350212699;12420.62738117858;12482.875171248172;19642.214311427382;20136.798632013786;20541.178352866016;20558;20627.278045268642;6631.801045968628;6638;6663.933360666429;6669.0329902164885;6698.631575263407;2516.5721827289403;2573.8069644776715;2575.1115865026536;2575.459153577732;2586.741325867436;3728.0307120148955;3794.165283637595;4208.410822484854;4305.289627211538;4374.496932852699;800.491687778265;837.3050368194384;840.2018082821344;867.4318321499428;886.1670030171618;559.5523581135076;572.3103660089582;592.4667798980952;596.9582129250998;606.4905479397328;9537.570809313598;9808.31341806081;10254.28220024606;10377.221708371751;10834.404107774148;601.3295175878951;602.4908951935607;604.7067172421372;629.1412222316596;635.1552435261092;4690;4701.459332176775;4743;4768.546988036131;4849.612031037508;71725;75477;75800.62099689466;76522.61738691383;77254;63642.36357636364;65397.34602654008;65496.34503654903;66483;67221.32778672151;56562.71718641381;57083.42916570864;58573.121403178986;59568;60302;9146.222571081267;9173.587188576397;9261.44431334122;9369.437833729999;9635.13283804461;27397.726022740313;27542.724572754018;27615;27772.86113569419;28516.857415712788;35364.29271414609;35610.46584301186;35642.46536302009;36144.73493427718;36505.63494365022;12912.741745164856;12932.094753367173;13279.535216267384;13389.19664820114;13509.932450337685;14234.14595124296;14246.07400518963;14288.214148221532;14414.351354189297;14496.057756245811;12451.066170037102;12586.622401327975;12738.808917866054;12744.6176614698;12798;13123.868761312264;13197.604071877859;13227.867721322664;13232.669183270495;13356.799648005093;12267.815982760445;12270.32513211782;12463.252204867737;12520.624381268577;12530.561430350259;8656.134386561294;8782.516961567175;8799.868001980103;10468;10558.947205263925;11616.303021818718;12467.189632673848;12498.750124987791;12523.686907827378;12627.11610187278 02:19:46 INFO - PID 4418 | __end_tp_report 02:19:46 INFO - PID 4418 | __start_cc_report 02:19:46 INFO - PID 4418 | _x_x_mozilla_cycle_collect,395 02:19:46 INFO - PID 4418 | __end_cc_report 02:19:46 INFO - PID 4418 | __startTimestamp1496049586796__endTimestamp 02:19:46 INFO - PID 4418 | 02:19:46 INFO - PID 4418 | ------- Summary: start ------- 02:19:46 INFO - PID 4418 | Number of tests: 6 02:19:46 INFO - PID 4418 | 02:19:46 INFO - PID 4418 | [#0] dojo.html Cycles:165 Average:5223.86 Median:5381.52 stddev:617.24 (11.5%) stddev-sans-first:587.51 02:19:46 INFO - PID 4418 | Values: 2737.6 2752.3 2761.7 2786.7 2788.2 5178.7 5253.8 5278.9 5288.8 5322.2 5278.8 5293.3 5302.3 5387.7 5399.2 4473.7 4677.9 4727.4 4734.0 4763.2 4787.3 4802.4 4825.8 4832.2 4851.9 4653.3 4698.4 4712.0 4754.2 4773.1 4670.2 4698.6 4720.2 4731.4 4745.5 4672.5 4697.3 4731.2 4734.1 4747.0 5263.1 5289.4 5311.8 5322.7 5360.7 5596.2 5616.6 5675.4 5682.8 5700.5 5794.2 5794.8 5797.7 5802.8 5869.6 5343.3 5355.9 5376.8 5379.3 5381.5 5704.7 5757.1 5809.2 5888.5 5910.0 5639.4 5653.7 5669.6 5670.3 5703.9 5733.9 5745.7 5756.6 5760.7 5765.0 5572.9 5606.7 5647.9 5729.7 5737.7 5614.9 5638.8 5688.7 5688.9 5717.8 4764.6 4770.8 4771.5 4803.3 4806.4 4101.8 4106.7 4116.4 4122.1 4150.5 4710.4 4729.0 4742.8 4776.8 4827.6 5741.3 5752.5 5755.7 5829.2 5846.1 4812.8 4846.8 4850.1 4850.4 4867.9 4826.2 4905.0 5023.6 5031.8 5041.9 5245.2 5321.0 5341.0 5342.0 5345.6 5625.6 5636.2 5654.7 5689.9 5725.7 5202.2 5314.0 5348.7 5377.0 5382.3 5607.2 5614.4 5614.9 5639.2 5643.8 5613.3 5719.7 5741.5 5762.6 5792.6 5582.4 5594.6 5598.1 5609.6 5637.7 5502.7 5585.0 5588.2 5591.9 5592.6 5337.7 5417.1 5422.7 5497.4 5574.1 5654.0 5665.3 5674.1 5696.6 5703.3 5412.1 5463.9 5464.3 5465.6 5471.8 02:19:46 INFO - PID 4418 | 02:19:46 INFO - PID 4418 | [#1] ext.html Cycles:180 Average:28392.78 Median:16387.13 stddev:37854.84 (231.0%) stddev-sans-first:37903.94 02:19:46 INFO - PID 4418 | Values: 706.4 743.5 764.6 1083.1 1104.2 31779.8 33580.0 33585.3 33701.0 33732.7 34723.0 35207.3 35220.0 35233.0 35240.6 6522.7 6698.3 6856.8 6976.2 6977.7 6690.7 6728.6 6794.2 6814.2 6814.4 6732.4 6768.2 6785.9 6795.3 6824.6 6759.5 6785.6 6788.6 6797.1 6805.1 6611.5 6655.6 6660.8 6685.6 6686.3 31399.0 31409.0 31413.4 31526.4 31538.4 3069.6 3097.2 3119.1 3119.2 3136.5 24734.5 24804.8 24879.6 24929.5 24992.9 2895.8 2984.4 3025.2 3045.7 3055.6 122171.4 123676.0 132646.3 141138.9 142368.0 38570.4 38821.4 38854.2 38945.8 38989.4 40311.6 40385.6 40460.4 40540.6 40549.0 12154.9 12204.3 12221.7 12265.6 12313.8 9805.8 9816.8 9850.1 9877.0 9880.6 12627.9 12638.0 12666.0 12695.6 12773.7 5246.9 5359.6 5369.1 5377.8 5412.5 857.5 906.1 907.6 925.8 944.7 19871.5 20912.6 20979.2 21012.6 21289.4 968.5 975.3 979.4 986.5 1004.2 10764.2 10991.5 11100.0 11177.5 11235.0 164117.0 164957.0 165353.0 165624.0 165700.2 39671.6 40016.8 40031.2 40090.8 40107.8 1181.2 1226.0 1235.6 1238.3 1238.6 19240.5 19804.3 20565.4 20577.9 20980.5 28549.0 28828.7 28874.4 28913.6 28929.7 139938.0 140364.0 140775.3 141386.0 142022.0 22318.3 22596.8 24766.4 28094.7 28234.3 29138.0 29789.9 30136.7 30437.4 30840.4 23624.5 23906.4 24236.6 24496.6 24818.0 23576.0 23602.1 23620.4 23767.3 23796.0 26193.7 26259.0 26271.0 26302.6 26355.5 22281.3 22745.5 23103.5 23416.2 27294.3 19268.4 22057.6 22091.6 22131.9 22220.9 02:19:46 INFO - PID 4418 | 02:19:46 INFO - PID 4418 | [#2] jquery.html Cycles:180 Average:24317.76 Median:38207.90 stddev:59731.36 (156.3%) stddev-sans-first:59871.93 02:19:46 INFO - PID 4418 | Values: 401.7 410.7 428.2 432.4 440.9 11761.2 13410.5 17247.6 17978.9 18019.8 13880.3 17363.1 17422.0 17478.9 17503.2 5207.4 5414.2 5431.3 5445.9 5471.3 5154.4 5333.4 5374.4 5398.6 5502.7 5288.9 5304.9 5306.7 5314.4 5317.5 5127.2 5161.6 5264.3 5290.6 5297.2 4804.5 4808.0 4810.3 4815.0 4831.3 20436.0 20583.4 20785.2 20872.9 20893.8 1596.2 1651.5 1662.7 1663.4 1664.5 14065.0 14250.0 14382.1 14487.0 14496.0 1988.2 2012.8 2023.8 2029.0 2033.7 90287.5 91484.0 92067.5 92824.5 93744.5 10623.9 10836.1 10999.7 11153.7 11191.2 14885.3 15416.7 15529.9 15557.1 15605.3 6902.4 7028.2 7127.1 7178.3 7256.5 6291.7 6320.7 6447.3 6492.2 6524.3 6717.2 6913.4 6961.0 6983.6 7154.5 2060.5 2067.1 2077.9 2104.2 2229.3 828.0 854.1 878.5 879.4 887.4 16212.4 16254.8 16450.8 16678.5 16781.3 851.6 853.7 863.0 869.6 886.3 9041.2 9050.0 9240.9 9279.7 9382.2 353739.0 354852.0 356576.0 356763.0 363757.0 75655.6 77105.0 77578.6 77607.0 78219.6 992.5 995.5 1015.9 1016.5 1029.6 13705.2 14045.8 14164.5 14167.3 14680.4 37174.6 37581.0 38071.0 38344.8 39186.0 47924.3 47987.5 49438.0 49466.5 50798.2 7535.5 7635.2 7745.9 7752.7 8103.5 12264.9 12373.6 12405.9 12741.9 13086.3 10400.4 11143.4 11186.0 11232.9 11750.3 10308.8 10561.4 10583.9 10605.4 10690.4 11366.0 11436.5 11519.7 11544.5 11736.3 7716.9 7971.5 8028.5 8102.6 8160.8 10926.8 11006.2 11128.3 11220.3 11285.2 02:19:46 INFO - PID 4418 | 02:19:46 INFO - PID 4418 | [#3] mootools.html Cycles:180 Average:6580.18 Median:3400.47 stddev:4310.67 (126.8%) stddev-sans-first:4304.12 02:19:46 INFO - PID 4418 | Values: 1244.8 1287.5 1295.3 1295.4 1304.7 10371.6 10913.3 10917.1 10952.6 11323.3 10971.9 11143.0 11183.9 11193.7 11194.7 2195.5 2219.8 2236.3 2237.6 2240.1 2198.9 2238.3 2243.8 2246.5 2251.0 2126.6 2151.1 2162.2 2172.0 2176.0 2134.1 2138.4 2145.7 2149.7 2150.9 1884.3 1953.4 2068.4 2132.6 2158.2 10696.7 10780.7 10793.5 10797.2 10797.3 5608.6 5851.3 5872.8 5880.3 5900.9 3215.6 3338.8 3388.7 3398.0 3402.9 1025.8 1039.8 1062.3 1087.2 1108.1 15869.0 15884.4 15962.5 16065.3 16090.2 4711.7 4775.7 4948.6 4969.6 4975.3 11454.9 11457.1 11485.4 11485.7 11490.3 5586.6 5715.0 5715.2 5723.5 5725.1 5083.4 5222.8 5234.1 5257.5 5258.0 4277.5 4335.5 4382.6 4456.8 4472.9 1301.7 1343.0 1366.8 1373.4 1379.4 705.2 722.5 727.8 738.3 747.7 5688.3 5772.9 5778.3 5804.9 5908.8 554.2 567.7 571.0 575.9 578.6 3751.8 4120.2 4129.0 4179.5 4244.0 13101.4 13732.7 14127.4 14146.6 14162.7 13642.9 13970.2 14112.4 14166.2 14284.6 7657.4 7741.9 7788.3 7856.1 7874.8 6034.4 6173.8 6200.8 6210.7 6294.2 12463.9 12556.2 12639.6 12829.9 12887.9 12894.0 12913.4 12921.7 13009.9 13078.7 8483.8 8578.0 8586.3 8591.1 8596.3 9799.9 9977.9 9979.9 10021.7 10049.9 8271.1 8307.5 8333.6 8387.4 8429.7 8222.5 8243.5 8355.6 8415.4 8428.7 7785.3 7807.0 7849.7 7854.9 7874.3 4821.7 5480.8 5539.3 5548.7 5626.7 5473.9 5680.0 5683.3 5752.2 5766.0 02:19:46 INFO - PID 4418 | 02:19:46 INFO - PID 4418 | [#4] prototype.html Cycles:180 Average:4803.44 Median:5316.07 stddev:1373.66 (25.8%) stddev-sans-first:1336.93 02:19:46 INFO - PID 4418 | Values: 387.6 393.2 393.7 393.8 396.7 5430.5 5445.4 5455.8 5471.3 5482.3 5185.3 5299.9 5314.3 5331.5 5336.5 4223.2 4229.5 4237.0 4238.1 4239.4 4191.9 4218.7 4225.7 4233.5 4234.7 3945.6 4105.5 4177.0 4189.5 4215.6 4117.2 4123.4 4124.9 4132.7 4133.5 3577.0 3587.6 3611.0 3615.1 3625.9 5189.2 5297.7 5314.6 5317.5 5343.6 4767.0 4832.5 4856.7 4859.6 4863.5 5712.6 5720.0 5721.8 5721.8 5731.4 3873.3 4058.8 4060.6 4069.4 4085.2 5933.9 5968.2 6064.5 6069.5 6122.5 4542.1 4564.4 4591.3 4593.8 4610.8 4665.9 4667.3 4670.7 4672.8 4687.1 5014.0 5101.8 5118.8 5125.3 5130.7 5779.3 5814.5 5814.8 5834.1 5837.8 1600.0 1615.0 1618.2 1618.6 1620.8 1142.9 1156.6 1161.7 1162.8 1176.6 4938.5 4992.7 4993.3 5004.3 5017.1 5973.3 5978.6 5983.0 5987.6 6000.7 4848.5 4937.2 4944.3 4968.9 4990.7 3154.5 3158.4 3171.7 3184.8 3192.7 5447.5 5534.9 5546.1 5597.2 5607.6 6095.9 6111.7 6165.7 6172.1 6181.5 5566.7 5569.1 5587.0 5619.8 5625.8 5785.1 5885.8 5915.3 5945.8 5962.7 5814.7 5841.0 5873.6 5887.1 5893.3 5354.4 5545.0 5547.4 5591.0 5595.2 4056.1 4114.2 4123.4 4134.5 4145.6 6006.0 6025.8 6028.0 6042.2 6042.8 5800.9 5819.6 5822.0 5835.0 5835.5 5671.5 5782.9 5832.9 5834.2 5842.6 5736.2 5749.9 5750.2 5768.3 5774.0 5646.4 5793.7 5853.0 5853.7 5901.6 5621.7 5627.4 5638.4 5639.1 5645.9 02:19:46 INFO - PID 4418 | 02:19:46 INFO - PID 4418 | [#5] yui.html Cycles:180 Average:16057.35 Median:3761.10 stddev:20572.87 (547.0%) stddev-sans-first:20598.33 02:19:46 INFO - PID 4418 | Values: 718.6 748.1 752.5 755.2 779.2 12202.0 12509.1 13227.7 14068.9 14157.5 15072.0 15636.6 15657.6 15672.1 15684.3 809.6 821.5 825.8 829.5 833.1 864.1 864.6 865.0 865.7 866.7 903.2 904.5 906.2 913.4 914.3 903.1 911.5 921.1 921.4 922.9 656.1 667.4 673.1 678.5 679.0 13148.5 13333.9 13365.3 13400.7 13450.3 14485.6 14902.8 15000.7 15000.8 15096.3 12334.6 12577.6 12670.7 12701.6 12926.2 2998.5 3007.7 3013.2 3013.5 3016.6 74245.0 75674.2 76838.8 77359.6 83491.0 12260.0 12264.8 12418.6 12420.6 12482.9 19642.2 20136.8 20541.2 20558.0 20627.3 6631.8 6638.0 6663.9 6669.0 6698.6 2516.6 2573.8 2575.1 2575.5 2586.7 3728.0 3794.2 4208.4 4305.3 4374.5 800.5 837.3 840.2 867.4 886.2 559.6 572.3 592.5 597.0 606.5 9537.6 9808.3 10254.3 10377.2 10834.4 601.3 602.5 604.7 629.1 635.2 4690.0 4701.5 4743.0 4768.5 4849.6 71725.0 75477.0 75800.6 76522.6 77254.0 63642.4 65397.3 65496.3 66483.0 67221.3 56562.7 57083.4 58573.1 59568.0 60302.0 9146.2 9173.6 9261.4 9369.4 9635.1 27397.7 27542.7 27615.0 27772.9 28516.9 35364.3 35610.5 35642.5 36144.7 36505.6 12912.7 12932.1 13279.5 13389.2 13509.9 14234.1 14246.1 14288.2 14414.4 14496.1 12451.1 12586.6 12738.8 12744.6 12798.0 13123.9 13197.6 13227.9 13232.7 13356.8 12267.8 12270.3 12463.3 12520.6 12530.6 8656.1 8782.5 8799.9 10468.0 10558.9 11616.3 12467.2 12498.8 12523.7 12627.1 02:19:46 INFO - PID 4418 | -------- Summary: end -------- 02:19:46 INFO - PID 4418 | 02:19:47 INFO - TEST-INFO | 4418: exit 0 02:19:47 INFO - TEST-OK | dromaeo_css | took 1148216ms 02:19:47 INFO - TEST-START | kraken 02:19:47 INFO - operating with platform_type : linux_ 02:19:47 INFO - Initialising browser for kraken test... 02:19:47 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58942/getInfo.html -profile /tmp/tmpCfmO6N/profile 02:19:47 INFO - TEST-INFO | started process 4824 (/builds/slave/test/build/application/firefox/firefox http://localhost:58942/getInfo.html) 02:20:22 INFO - TEST-INFO | 4824: killed by SIGTERM 02:20:22 INFO - Browser initialized. 02:20:22 INFO - Running cycle 1/1 for kraken test... 02:20:22 INFO - TEST-INFO | started process 5025 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCfmO6N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:20:35 INFO - PID 5025 | RSS: Main: 182075392 02:20:35 INFO - PID 5025 | 02:20:37 INFO - PID 5025 | Cycle 1(1): loaded http://localhost:58942/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58942/tests/kraken/driver.html?testName=audio-beat-detection) 02:20:38 INFO - PID 5025 | RSS: Main: 185794560 02:20:38 INFO - PID 5025 | 02:20:41 INFO - PID 5025 | Cycle 1(1): loaded http://localhost:58942/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58942/tests/kraken/driver.html?testName=audio-dft) 02:20:42 INFO - PID 5025 | RSS: Main: 184909824 02:20:42 INFO - PID 5025 | 02:20:45 INFO - PID 5025 | Cycle 1(1): loaded http://localhost:58942/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58942/tests/kraken/driver.html?testName=audio-fft) 02:20:45 INFO - PID 5025 | RSS: Main: 182005760 02:20:45 INFO - PID 5025 | 02:20:47 INFO - PID 5025 | Cycle 1(1): loaded http://localhost:58942/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58942/tests/kraken/driver.html?testName=audio-oscillator) 02:20:48 INFO - PID 5025 | RSS: Main: 181915648 02:20:48 INFO - PID 5025 | 02:20:50 INFO - PID 5025 | Cycle 1(1): loaded http://localhost:58942/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58942/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:20:51 INFO - PID 5025 | RSS: Main: 182378496 02:20:51 INFO - PID 5025 | 02:20:54 INFO - PID 5025 | Cycle 1(1): loaded http://localhost:58942/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58942/tests/kraken/driver.html?testName=imaging-darkroom) 02:20:54 INFO - PID 5025 | RSS: Main: 183357440 02:20:54 INFO - PID 5025 | 02:20:58 INFO - PID 5025 | Cycle 1(1): loaded http://localhost:58942/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58942/tests/kraken/driver.html?testName=imaging-desaturate) 02:20:59 INFO - PID 5025 | RSS: Main: 182677504 02:20:59 INFO - PID 5025 | 02:21:01 INFO - PID 5025 | Cycle 1(1): loaded http://localhost:58942/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58942/tests/kraken/driver.html?testName=json-parse-financial) 02:21:02 INFO - PID 5025 | RSS: Main: 183140352 02:21:02 INFO - PID 5025 | 02:21:04 INFO - PID 5025 | Cycle 1(1): loaded http://localhost:58942/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58942/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:21:04 INFO - PID 5025 | RSS: Main: 183599104 02:21:04 INFO - PID 5025 | 02:21:06 INFO - PID 5025 | Cycle 1(1): loaded http://localhost:58942/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58942/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:21:07 INFO - PID 5025 | RSS: Main: 183226368 02:21:07 INFO - PID 5025 | 02:21:09 INFO - PID 5025 | Cycle 1(1): loaded http://localhost:58942/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58942/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:21:10 INFO - PID 5025 | RSS: Main: 182796288 02:21:10 INFO - PID 5025 | 02:21:13 INFO - PID 5025 | Cycle 1(1): loaded http://localhost:58942/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58942/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:21:13 INFO - PID 5025 | RSS: Main: 182906880 02:21:13 INFO - PID 5025 | 02:21:16 INFO - PID 5025 | Cycle 1(1): loaded http://localhost:58942/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58942/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:21:17 INFO - PID 5025 | RSS: Main: 182726656 02:21:17 INFO - PID 5025 | 02:21:19 INFO - PID 5025 | Cycle 1(1): loaded http://localhost:58942/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58942/tests/kraken/driver.html?testName=ai-astar) 02:21:19 INFO - PID 5025 | RSS: Main: 184238080 02:21:19 INFO - PID 5025 | 02:21:19 INFO - PID 5025 | __start_tp_report 02:21:19 INFO - PID 5025 | _x_x_mozilla_page_load 02:21:19 INFO - PID 5025 | _x_x_mozilla_page_load_details 02:21:19 INFO - PID 5025 | |i|pagename|runs| 02:21:19 INFO - PID 5025 | |0;ai-astar;103;113;110;111;111;111;111;111;112;111 02:21:19 INFO - PID 5025 | |1;audio-beat-detection;149;127;125;169;127;122;126;125;150;133 02:21:19 INFO - PID 5025 | |2;audio-dft;163;165;164;165;169;179;165;164;162;165 02:21:19 INFO - PID 5025 | |3;audio-fft;74;76;75;112;75;74;74;74;99;74 02:21:19 INFO - PID 5025 | |4;audio-oscillator;84;83;107;84;83;83;99;83;82;109 02:21:19 INFO - PID 5025 | |5;imaging-gaussian-blur;113;115;114;114;114;114;114;114;114;115 02:21:19 INFO - PID 5025 | |6;imaging-darkroom;151;151;150;150;151;152;151;153;155;150 02:21:19 INFO - PID 5025 | |7;imaging-desaturate;95;96;94;96;95;94;94;96;96;95 02:21:19 INFO - PID 5025 | |8;json-parse-financial;55;55;56;56;56;56;58;57;56;57 02:21:19 INFO - PID 5025 | |9;json-stringify-tinderbox;57;57;57;57;56;56;57;57;60;57 02:21:19 INFO - PID 5025 | |10;stanford-crypto-aes;89;99;98;90;90;89;92;92;132;87 02:21:19 INFO - PID 5025 | |11;stanford-crypto-ccm;134;137;150;136;132;135;134;135;132;134 02:21:19 INFO - PID 5025 | |12;stanford-crypto-pbkdf2;189;190;197;193;200;193;184;197;197;194 02:21:19 INFO - PID 5025 | |13;stanford-crypto-sha256-iterative;76;75;79;71;72;72;74;72;72;76 02:21:19 INFO - PID 5025 | __end_tp_report 02:21:19 INFO - PID 5025 | __start_cc_report 02:21:19 INFO - PID 5025 | _x_x_mozilla_cycle_collect,1019 02:21:19 INFO - PID 5025 | __end_cc_report 02:21:19 INFO - PID 5025 | __startTimestamp1496049679584__endTimestamp 02:21:19 INFO - PID 5025 | 02:21:19 INFO - PID 5025 | ------- Summary: start ------- 02:21:19 INFO - PID 5025 | Number of tests: 14 02:21:19 INFO - PID 5025 | 02:21:19 INFO - PID 5025 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:2.72 (2.4%) stddev-sans-first:0.83 02:21:19 INFO - PID 5025 | Values: 103.0 113.0 110.0 111.0 111.0 111.0 111.0 111.0 112.0 111.0 02:21:19 INFO - PID 5025 | 02:21:19 INFO - PID 5025 | [#1] audio-beat-detection Cycles:10 Average:135.30 Median:130.00 stddev:15.49 (11.9%) stddev-sans-first:15.61 02:21:19 INFO - PID 5025 | Values: 149.0 127.0 125.0 169.0 127.0 122.0 126.0 125.0 150.0 133.0 02:21:19 INFO - PID 5025 | 02:21:19 INFO - PID 5025 | [#2] audio-dft Cycles:10 Average:166.10 Median:165.00 stddev:4.89 (3.0%) stddev-sans-first:5.05 02:21:19 INFO - PID 5025 | Values: 163.0 165.0 164.0 165.0 169.0 179.0 165.0 164.0 162.0 165.0 02:21:19 INFO - PID 5025 | 02:21:19 INFO - PID 5025 | [#3] audio-fft Cycles:10 Average:80.70 Median:74.50 stddev:13.44 (18.0%) stddev-sans-first:14.04 02:21:19 INFO - PID 5025 | Values: 74.0 76.0 75.0 112.0 75.0 74.0 74.0 74.0 99.0 74.0 02:21:19 INFO - PID 5025 | 02:21:19 INFO - PID 5025 | [#4] audio-oscillator Cycles:10 Average:89.70 Median:83.00 stddev:10.86 (13.1%) stddev-sans-first:11.32 02:21:19 INFO - PID 5025 | Values: 84.0 83.0 107.0 84.0 83.0 83.0 99.0 83.0 82.0 109.0 02:21:19 INFO - PID 5025 | 02:21:19 INFO - PID 5025 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 02:21:19 INFO - PID 5025 | Values: 113.0 115.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 115.0 02:21:19 INFO - PID 5025 | 02:21:19 INFO - PID 5025 | [#6] imaging-darkroom Cycles:10 Average:151.40 Median:151.00 stddev:1.58 (1.0%) stddev-sans-first:1.67 02:21:19 INFO - PID 5025 | Values: 151.0 151.0 150.0 150.0 151.0 152.0 151.0 153.0 155.0 150.0 02:21:19 INFO - PID 5025 | 02:21:19 INFO - PID 5025 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.50 stddev:0.88 (0.9%) stddev-sans-first:0.93 02:21:19 INFO - PID 5025 | Values: 95.0 96.0 94.0 96.0 95.0 94.0 94.0 96.0 96.0 95.0 02:21:19 INFO - PID 5025 | 02:21:19 INFO - PID 5025 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.00 stddev:0.92 (1.6%) stddev-sans-first:0.87 02:21:19 INFO - PID 5025 | Values: 55.0 55.0 56.0 56.0 56.0 56.0 58.0 57.0 56.0 57.0 02:21:19 INFO - PID 5025 | 02:21:19 INFO - PID 5025 | [#9] json-stringify-tinderbox Cycles:10 Average:57.10 Median:57.00 stddev:1.10 (1.9%) stddev-sans-first:1.17 02:21:19 INFO - PID 5025 | Values: 57.0 57.0 57.0 57.0 56.0 56.0 57.0 57.0 60.0 57.0 02:21:19 INFO - PID 5025 | 02:21:19 INFO - PID 5025 | [#10] stanford-crypto-aes Cycles:10 Average:95.80 Median:91.00 stddev:13.30 (14.6%) stddev-sans-first:13.88 02:21:19 INFO - PID 5025 | Values: 89.0 99.0 98.0 90.0 90.0 89.0 92.0 92.0 132.0 87.0 02:21:19 INFO - PID 5025 | 02:21:19 INFO - PID 5025 | [#11] stanford-crypto-ccm Cycles:10 Average:135.90 Median:135.00 stddev:5.20 (3.8%) stddev-sans-first:5.46 02:21:19 INFO - PID 5025 | Values: 134.0 137.0 150.0 136.0 132.0 135.0 134.0 135.0 132.0 134.0 02:21:19 INFO - PID 5025 | 02:21:19 INFO - PID 5025 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.40 Median:195.50 stddev:4.74 (2.4%) stddev-sans-first:4.76 02:21:19 INFO - PID 5025 | Values: 189.0 190.0 197.0 193.0 200.0 193.0 184.0 197.0 197.0 194.0 02:21:19 INFO - PID 5025 | 02:21:19 INFO - PID 5025 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.90 Median:74.50 stddev:2.56 (3.4%) stddev-sans-first:2.60 02:21:19 INFO - PID 5025 | Values: 76.0 75.0 79.0 71.0 72.0 72.0 74.0 72.0 72.0 76.0 02:21:19 INFO - PID 5025 | -------- Summary: end -------- 02:21:19 INFO - PID 5025 | 02:21:20 INFO - TEST-INFO | 5025: exit 0 02:21:20 INFO - TEST-OK | kraken | took 93126ms 02:21:20 INFO - SUITE-END | took 1241s 02:21:21 INFO - Completed test suite (00:20:41) 02:21:21 INFO - javascript benchmark 02:21:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6702.531085901929, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2737.603047558104, 2752.2568906395263, 2761.654793150856, 2786.749192572668, 2788.1914244869004, 5178.66338687985, 5253.763580638875, 5278.917821846522, 5288.8413347599635, 5322.201669749539, 5278.762455689493, 5293.338332708411, 5302.3106996090555, 5387.703676297802, 5399.19012148178, 4473.731576105444, 4677.88305292367, 4727.409073865767, 4734.0, 4763.166445871959, 4787.257975013861, 4802.35168252285, 4825.7587120644, 4832.1543729847135, 4851.927221091669, 4653.348531205634, 4698.365720627706, 4711.976440117777, 4754.191787396151, 4773.11697335994, 4670.206064968964, 4698.553637404441, 4720.197566413718, 4731.408573928259, 4745.501722319142, 4672.509386514401, 4697.295405689139, 4731.2430011198385, 4734.147853386389, 4747.0, 5263.105272103713, 5289.3917199521775, 5311.787528498855, 5322.7072511011875, 5360.678359298455, 5596.2165296858475, 5616.606837521375, 5675.432456754333, 5682.801101961411, 5700.515456186229, 5794.246747922785, 5794.768209271624, 5797.681127537984, 5802.767889284423, 5869.589128760988, 5343.305370301913, 5355.946440535545, 5376.758045887945, 5379.273798037215, 5381.515663590218, 5704.743286552115, 5757.13642953552, 5809.24479817621, 5888.499477544457, 5909.970450147808, 5639.436056394327, 5653.745581448845, 5669.574781891292, 5670.319561652628, 5703.914441283384, 5733.8566535836935, 5745.712714364265, 5756.5682573807135, 5760.74076666551, 5764.971175144097, 5572.888542229132, 5606.6916319602815, 5647.858803529944, 5729.684867332337, 5737.655740655574, 5614.9157762633595, 5638.774449022075, 5688.687122208235, 5688.943110568925, 5717.828465146053, 4764.618830493621, 4770.76146192689, 4771.5228477152705, 4803.255495398219, 4806.44725856524, 4101.753894766323, 4106.67146628269, 4116.361963895601, 4122.093139509303, 4150.460440142762, 4710.364100846342, 4728.976355118271, 4742.834000809955, 4776.832810851603, 4827.565519103297, 5741.282339707536, 5752.539796816244, 5755.65466072037, 5829.242198514166, 5846.1230815377185, 4812.831550895772, 4846.75766211688, 4850.1269771440775, 4850.369451971292, 4867.902641947212, 4826.203676393356, 4905.0189962007025, 5023.572996295283, 5031.823886163967, 5041.949580504222, 5245.239440281214, 5321.0, 5341.038613049688, 5342.011727830364, 5345.572354211731, 5625.606207565431, 5636.239107720406, 5654.6889921054735, 5689.914651280317, 5725.7137143141845, 5202.24567437727, 5314.0, 5348.679079255257, 5376.973115134399, 5382.30030096085, 5607.186957891165, 5614.410486898817, 5614.943850561442, 5639.182318563703, 5643.83068507929, 5613.326400831927, 5719.742611582572, 5741.483266506035, 5762.596618236683, 5792.5655575832825, 5582.3859375467855, 5594.636348637326, 5598.10430331145, 5609.6073274872, 5637.689927054052, 5502.661368918274, 5585.0, 5588.217649529151, 5591.8881622368135, 5592.636478628876, 5337.733113344239, 5417.052015897123, 5422.701751403552, 5497.422770609029, 5574.080276754452, 5654.0, 5665.3201615806365, 5674.120511320752, 5696.601237913472, 5703.287089113861, 5412.052890744183, 5463.863403414946, 5464.344278686424, 5465.6447330923365, 5471.8084867029465], "value": 5178.961205740244, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.448969803553, 743.5315751076822, 764.5833021003551, 1083.0956151613398, 1104.1718710966775, 31779.841100794492, 33580.0, 33585.32829343412, 33701.0, 33732.662673373256, 34723.0, 35207.295854082906, 35220.0, 35233.0, 35240.64759352406, 6522.706478208492, 6698.263191049005, 6856.82857928552, 6976.162860456752, 6977.686004129801, 6690.7323707051655, 6728.629925354104, 6794.184697836242, 6814.182298124232, 6814.352636499525, 6732.360425759545, 6768.153980752406, 6785.932140678604, 6795.252522222551, 6824.590524568542, 6759.526833121683, 6785.59286442815, 6788.558743681694, 6797.116374871284, 6805.081314022643, 6611.537192396486, 6655.600663960129, 6660.800175994728, 6685.598864068172, 6686.331366863324, 31399.0, 31409.0, 31413.37173256522, 31526.36947261042, 31538.36923261545, 3069.570260163579, 3097.1792474994145, 3119.1110533497845, 3119.2357872321427, 3136.52952057191, 24734.505309893702, 24804.751952480423, 24879.62680559793, 24929.50140997188, 24992.875035624886, 2895.753860921824, 2984.4180384824967, 3025.243689077731, 3045.710657487535, 3055.6027716396948, 122171.3891430546, 123676.0, 132646.3367683165, 141138.88291675632, 142368.0, 38570.421443678366, 38821.41767873484, 38854.22291554153, 38945.80527097346, 38989.415158772645, 40311.59688403078, 40385.59614403877, 40460.39309410361, 40540.594594053684, 40549.0, 12154.87845121555, 12204.328761918003, 12221.69445763863, 12265.57070502546, 12313.815292770616, 9805.754856128511, 9816.821981362282, 9850.064243896819, 9876.950615246878, 9880.604775808888, 12627.873721262853, 12638.0, 12666.0, 12695.619131426072, 12773.744525109445, 5246.895062098813, 5359.571234301325, 5369.140937450067, 5377.8117765878005, 5412.512873841373, 857.511218605389, 906.1346414174448, 907.5598334807613, 925.7731855695398, 944.7496413450441, 19871.51606049244, 20912.581748365254, 20979.160833566486, 21012.579748404947, 21289.36131916045, 968.4625033106553, 975.3026585990908, 979.3829887171037, 986.4820968991194, 1004.2016596805557, 10764.192685548614, 10991.450427478754, 11100.0, 11177.49701263445, 11235.0, 164117.0, 164957.0, 165353.0, 165624.0, 165700.17149914172, 39671.60328396679, 40016.79991600024, 40031.199376012315, 40090.79954600208, 40107.799461003095, 1181.1769966994989, 1225.9816102758466, 1235.5922545559943, 1238.3313010973973, 1238.6284114765535, 19240.518987024876, 19804.306849260207, 20565.38303850887, 20577.89711051495, 20980.475488112308, 28549.0, 28828.711712882603, 28874.42251154923, 28913.56629650515, 28929.710702893542, 139938.0, 140364.0, 140775.29612351872, 141386.0, 142022.0, 22318.330450086523, 22596.774032260124, 24766.38084047913, 28094.71905280921, 28234.2941426466, 29138.0, 29789.851050744608, 30136.698633013388, 30437.391252174388, 30840.383192336478, 23624.52750944937, 23906.40233994164, 24236.63645045361, 24496.632550512113, 24818.0, 23576.0, 23602.055917763097, 23620.409489762893, 23767.286981390585, 23796.048158074176, 26193.73806261913, 26259.0, 26271.0, 26302.60546091772, 26355.4728905417, 22281.331560053226, 22745.545089098458, 23103.53792924166, 23416.180433684738, 27294.31764205831, 19268.4219473416, 22057.558848823253, 22091.55816883621, 22131.889340553837, 22220.888895555418], "value": 13909.752608870782, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.72281126023023, 410.65299821650694, 428.209952637384, 432.431352771106, 440.9470863496381, 11761.20528054113, 13410.530631427902, 17247.568810779736, 17978.91010544947, 18019.81980180198, 13880.30598470075, 17363.131843407842, 17422.0, 17478.912605436988, 17503.212355444004, 5207.375114986197, 5414.1608050752, 5431.34823821142, 5445.918311225335, 5471.288732464774, 5154.355705536808, 5333.4399888011785, 5374.408815030363, 5398.649087809299, 5502.724863756816, 5288.947110528884, 5304.867378315535, 5306.655067420625, 5314.362276526803, 5317.521423071923, 5127.230915362688, 5161.587073034167, 5264.315638966929, 5290.60320475962, 5297.17893726473, 4804.495527969548, 4807.975960120212, 4810.326554282403, 4814.951850481485, 4831.323614693945, 20436.0, 20583.38249852492, 20785.16859325625, 20872.895635521876, 20893.791062089487, 1596.2338077722643, 1651.5293141454747, 1662.6840900228917, 1663.4178037686834, 1664.45905080848, 14065.0, 14250.0, 14382.065165764192, 14487.0, 14496.0, 1988.1749074134218, 2012.818846303825, 2023.7976202379791, 2029.0362078012972, 2033.6644453665128, 90287.54856225676, 91484.0, 92067.53966230193, 92824.53587732086, 93744.53127734318, 10623.89376106229, 10836.133109351233, 10999.670009899715, 11153.72115697114, 11191.216614837045, 14885.255737213312, 15416.691666166838, 15529.922350388175, 15557.14435706047, 15605.297761600528, 6902.378785909293, 7028.156621205488, 7127.144742630918, 7178.318059784312, 7256.492045556761, 6291.6854157291955, 6320.683965801783, 6447.25856526496, 6492.156019717407, 6524.282328943812, 6717.227518835299, 6913.412359949461, 6960.965195173992, 6983.615901125385, 7154.534955227893, 2060.47457898238, 2067.12147337381, 2077.8649387789746, 2104.1793700456833, 2229.308914236592, 827.9586020699062, 854.0562678240578, 878.5168157513342, 879.3580686099183, 887.4276091920675, 16212.432564860173, 16254.800675456914, 16450.75323870119, 16678.49964501067, 16781.328746849988, 851.5997481183833, 853.701204578405, 862.9827403451895, 869.604330029835, 886.2644005475569, 9041.23149532297, 9050.0, 9240.8613870792, 9279.721608351625, 9382.155605995493, 353739.0, 354852.0, 356576.0, 356763.0, 363757.0, 75655.62172189103, 77105.0, 77578.61210693911, 77607.0, 78219.60890195513, 992.4690290694443, 995.4723996281982, 1015.9238057145743, 1016.5120742043861, 1029.6499190275342, 13705.246211458465, 14045.789313160107, 14164.504242351468, 14167.291635418394, 14680.41278348854, 37174.628253717114, 37581.0, 38071.0, 38344.80827595844, 39186.0, 47924.28113578369, 47987.520124798306, 49438.0, 49466.50533494619, 50798.23802643037, 7535.54786712799, 7635.23647635232, 7745.922540774745, 7752.689892404241, 8103.513789172668, 12264.938675306923, 12373.566925157576, 12405.937970310451, 12741.872581274069, 13086.345682716017, 10400.375977441076, 11143.442827858737, 11186.0, 11232.943835280772, 11750.29498230109, 10308.845367319645, 10561.366318020944, 10583.94708026455, 10605.363678179334, 10690.41202733826, 11366.0, 11436.485358159069, 11519.712007199552, 11544.480498377425, 11736.295822250693, 7716.922830771845, 7971.481853679492, 8028.4781489203015, 8102.635381407733, 8160.755177344689, 10926.836097458703, 11006.229563930448, 11128.276662016942, 11220.270682405617, 11285.21003529745], "value": 8596.44459071149, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1244.7634949359622, 1287.5043108403263, 1295.3134838535573, 1295.4300107952497, 1304.6738315421144, 10371.585136594536, 10913.290636108648, 10917.126629869612, 10952.616658416957, 11323.32060076396, 10971.945140274307, 11143.0, 11183.944080279587, 11193.72015699608, 11194.66416007521, 2195.5279614882797, 2219.8113160381386, 2236.3291012696127, 2237.5748607764554, 2240.1263507232193, 2198.912043518257, 2238.328501449567, 2243.8317126215516, 2246.528229071897, 2250.9887450562724, 2126.5959467701164, 2151.107290474459, 2162.221600223926, 2171.9891400543056, 2176.042541281831, 2134.125008746414, 2138.3905586907813, 2145.6888751131078, 2149.6668016457475, 2150.903209355583, 1884.3028079610494, 1953.4139758072522, 2068.389825001628, 2132.616129096762, 2158.2338269914267, 10696.732581685443, 10780.676579702544, 10793.514291856885, 10797.190210734227, 10797.29817561856, 5608.6073974821775, 5851.268591426072, 5872.823815285506, 5880.26496687914, 5900.881982360372, 3215.614126304835, 3338.7996720196866, 3388.7289016878835, 3398.0, 3402.931941361184, 1025.7743296474764, 1039.8076355874111, 1062.2564205056415, 1087.1846115413439, 1108.1467270201979, 15869.0, 15884.444044458503, 15962.521124366287, 16065.277062532214, 16090.195490225442, 4711.717296962193, 4775.71345719258, 4948.554630083309, 4969.602431805447, 4975.328330675385, 11454.94272528632, 11457.083433325313, 11485.368304743319, 11485.712857178638, 11490.310581365145, 5586.608937374344, 5715.0, 5715.199872017921, 5723.456271654186, 5725.112607545837, 5083.364579427572, 5222.843314700565, 5234.057869583511, 5257.4742525747115, 5258.0, 4277.529471758104, 4335.458067741532, 4382.605565499057, 4456.799444025027, 4472.932906006413, 1301.711305807263, 1342.9597112086653, 1366.7744822104241, 1373.3819781098546, 1379.4413262628652, 705.1608585782902, 722.4689852958072, 727.8216836874999, 738.3391864281438, 747.6672880568203, 5688.288963879515, 5772.884542309131, 5778.27771528559, 5804.854878628068, 5908.793192238251, 554.1964151979646, 567.6677900722784, 571.0349509329303, 575.8502789274735, 578.6412424296963, 3751.8311675974646, 4120.1553681495225, 4129.0, 4179.540250572434, 4244.0, 13101.41043653038, 13732.725345493034, 14127.364268607731, 14146.575602731935, 14162.71674566503, 13642.93178534101, 13970.231637259845, 14112.364943577564, 14166.150030998173, 14284.642883927985, 7657.387409007378, 7741.922580774233, 7788.337991270692, 7856.135825059239, 7874.803129921798, 6034.366391529002, 6173.81478555644, 6200.844978875564, 6210.658413787285, 6294.213223347082, 12463.875361246271, 12556.246625202517, 12639.620811375673, 12829.93585032069, 12887.871121288666, 12894.0, 12913.354332283161, 12921.676958075746, 13009.934950325187, 13078.738425231251, 8483.830323393375, 8578.013528444058, 8586.270167035871, 8591.140885911358, 8596.269317108116, 9799.902000980184, 9977.900220997697, 9979.850302245326, 10021.749456263651, 10049.89950100519, 8271.090180080066, 8307.501549907025, 8333.583320834055, 8387.412881098264, 8429.704960326359, 8222.547759873265, 8243.464174828618, 8355.582220889053, 8415.410921235454, 8428.704995325133, 7785.338246249133, 7807.0, 7849.686012559434, 7854.882176767467, 7874.251946065115, 4821.710697358169, 5480.753366098615, 5539.307586551681, 5548.722563871871, 5626.718664066862, 5473.917891231555, 5680.0, 5683.261176047087, 5752.223449834219, 5766.048601980794], "value": 4868.214565281714, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.6259409669668, 393.2057244366379, 393.67521794519513, 393.80113042913325, 396.74806497873857, 5430.456954304573, 5445.401005889354, 5455.754491047903, 5471.316085489314, 5482.314710661168, 5185.325907632003, 5299.947000529994, 5314.282571852798, 5331.494197727072, 5336.493033161853, 4223.176480586287, 4229.489523695341, 4237.046664500478, 4238.109996900655, 4239.3852891330735, 4191.937120943188, 4218.704690671654, 4225.746455212682, 4233.470816147981, 4234.724742891717, 3945.5857135000842, 4105.50733911931, 4177.0, 4189.455370801791, 4215.620594146526, 4117.2177286315655, 4123.402106694542, 4124.855630052949, 4132.690048246393, 4133.4626498555, 3576.9642303576893, 3587.641235876418, 3611.043073585502, 3615.096225943514, 3625.873094441682, 5189.195674670432, 5297.735113244361, 5314.60140489461, 5317.54800841925, 5343.572514198893, 4767.0, 4832.540908613676, 4856.708597484162, 4859.611231101503, 4863.540937718705, 5712.600117991742, 5719.971400143014, 5721.828345149652, 5721.828345149652, 5731.426857314277, 3873.341531939549, 4058.797060146981, 4060.5736397678115, 4069.433268191738, 4085.22380747657, 5933.9406605934255, 5968.1942937703725, 6064.545159113084, 6069.453749162597, 6122.510199184099, 4542.11428771393, 4564.3838081859185, 4591.265397536378, 4593.839215627437, 4610.76946152691, 4665.86002419928, 4667.32323813052, 4670.660477758419, 4672.836450724209, 4687.10944920464, 5014.044522636174, 5101.795928162832, 5118.820841270612, 5125.256837758504, 5130.666506677128, 5779.33537643168, 5814.534837213013, 5814.76740930358, 5834.124881267844, 5837.766489340379, 1600.0479714569813, 1614.9515514534583, 1618.1747308872325, 1618.6358069434518, 1620.7811945387457, 1142.9371384573928, 1156.6414411532285, 1161.7444162284285, 1162.7965106106396, 1176.5587904535798, 4938.456769755324, 4992.72540010303, 4993.251012348177, 5004.299398084271, 5017.096922553902, 5973.253343332083, 5978.611390259706, 5982.982892908216, 5987.64074155552, 6000.729967151488, 4848.539388758062, 4937.21004639256, 4944.307796908363, 4968.90062198754, 4990.700557966534, 3154.511050787132, 3158.3999040182753, 3171.7154552406314, 3184.8407579620925, 3192.664770199142, 5447.494152689728, 5534.916976245359, 5546.112621980464, 5597.160425936142, 5607.607467477319, 6095.933211687937, 6111.694415279308, 6165.691715414211, 6172.105044768573, 6181.474574661204, 5566.666000040011, 5569.081101618269, 5587.022271102541, 5619.831405057855, 5625.831225063254, 5785.132230165341, 5885.764569417347, 5915.349311575809, 5945.821625351246, 5962.731677074456, 5814.680192589448, 5841.0, 5873.647581145145, 5887.145549152004, 5893.320403684929, 5354.437784032621, 5544.972275138599, 5547.362053363753, 5591.0, 5595.188697638901, 4056.1076563156057, 4114.177164567159, 4123.402106694452, 4134.524529679125, 4145.564715704808, 6005.969970150121, 6025.78909738157, 6027.969860150672, 6042.1843051187525, 6042.758289668364, 5800.9419905800405, 5819.632386389279, 5822.0, 5834.986929509312, 5835.503982161564, 5671.546276297804, 5782.855428614318, 5832.854178645568, 5834.241548598655, 5842.561807864342, 5736.168255602831, 5749.942500574941, 5750.194972703908, 5768.278965129359, 5773.971130144322, 5646.435356464485, 5793.739281732416, 5853.0, 5853.736581853912, 5901.645901245939, 5621.67131308898, 5627.352854421794, 5638.407967163553, 5639.097744360883, 5645.943540564706], "value": 4396.484953824404, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.604767377942, 748.128430378609, 752.5146280648978, 755.1881727143322, 779.177967244557, 12202.0, 12509.061820363464, 13227.669308267286, 14068.859311406883, 14157.45165870143, 15072.0, 15636.609084772886, 15657.608559786011, 15672.138032408213, 15684.294206760695, 809.6194788449434, 821.4619424277108, 825.8141918068417, 829.4608504472081, 833.1377024779355, 864.0754392799707, 864.5893200729635, 864.9654013839439, 865.7056600755742, 866.6663334616155, 903.2322525853006, 904.5115637555712, 906.207068814787, 913.3789023464075, 914.3051281026401, 903.1104362203224, 911.48956584313, 921.0835218957113, 921.4471317209687, 922.8661844032578, 656.1011414362354, 667.3993405934649, 673.0879658063303, 678.4809620640215, 678.9524733268673, 13148.53980110701, 13333.866661333359, 13365.33173341329, 13400.664983375493, 13450.327483625779, 14485.637859053502, 14902.776458353133, 15000.699986000329, 15000.774988375184, 15096.320665570076, 12334.629961101182, 12577.559785407559, 12670.683232919158, 12701.618951431472, 12926.15979961309, 2998.4602771501122, 3007.6541197762317, 3013.246688327918, 3013.547967804847, 3016.577679124924, 74245.0, 75674.24325756727, 76838.84741728935, 77359.61320193364, 83491.0, 12260.0, 12264.754704905852, 12418.565350212699, 12420.62738117858, 12482.875171248172, 19642.214311427382, 20136.798632013786, 20541.178352866016, 20558.0, 20627.278045268642, 6631.801045968628, 6638.0, 6663.933360666429, 6669.0329902164885, 6698.631575263407, 2516.5721827289403, 2573.8069644776715, 2575.1115865026536, 2575.459153577732, 2586.741325867436, 3728.0307120148955, 3794.165283637595, 4208.410822484854, 4305.289627211538, 4374.496932852699, 800.491687778265, 837.3050368194384, 840.2018082821344, 867.4318321499428, 886.1670030171618, 559.5523581135076, 572.3103660089582, 592.4667798980952, 596.9582129250998, 606.4905479397328, 9537.570809313598, 9808.31341806081, 10254.28220024606, 10377.221708371751, 10834.404107774148, 601.3295175878951, 602.4908951935607, 604.7067172421372, 629.1412222316596, 635.1552435261092, 4690.0, 4701.459332176775, 4743.0, 4768.546988036131, 4849.612031037508, 71725.0, 75477.0, 75800.62099689466, 76522.61738691383, 77254.0, 63642.36357636364, 65397.34602654008, 65496.34503654903, 66483.0, 67221.32778672151, 56562.71718641381, 57083.42916570864, 58573.121403178986, 59568.0, 60302.0, 9146.222571081267, 9173.587188576397, 9261.44431334122, 9369.437833729999, 9635.13283804461, 27397.726022740313, 27542.724572754018, 27615.0, 27772.86113569419, 28516.857415712788, 35364.29271414609, 35610.46584301186, 35642.46536302009, 36144.73493427718, 36505.63494365022, 12912.741745164856, 12932.094753367173, 13279.535216267384, 13389.19664820114, 13509.932450337685, 14234.14595124296, 14246.07400518963, 14288.214148221532, 14414.351354189297, 14496.057756245811, 12451.066170037102, 12586.622401327975, 12738.808917866054, 12744.6176614698, 12798.0, 13123.868761312264, 13197.604071877859, 13227.867721322664, 13232.669183270495, 13356.799648005093, 12267.815982760445, 12270.32513211782, 12463.252204867737, 12520.624381268577, 12530.561430350259, 8656.134386561294, 8782.516961567175, 8799.868001980103, 10468.0, 10558.947205263925, 11616.303021818718, 12467.189632673848, 12498.750124987791, 12523.686907827378, 12627.11610187278], "value": 6839.879986546583, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1555.1000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 110.0, 111.0, 111.0, 111.0, 111.0, 111.0, 112.0, 111.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 127.0, 125.0, 169.0, 127.0, 122.0, 126.0, 125.0, 150.0, 133.0], "value": 135.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 164.0, 165.0, 169.0, 179.0, 165.0, 164.0, 162.0, 165.0], "value": 166.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 112.0, 75.0, 74.0, 74.0, 74.0, 99.0, 74.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 107.0, 84.0, 83.0, 83.0, 99.0, 83.0, 82.0, 109.0], "value": 89.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 115.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 150.0, 150.0, 151.0, 152.0, 151.0, 153.0, 155.0, 150.0], "value": 151.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 94.0, 96.0, 95.0, 94.0, 94.0, 96.0, 96.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 56.0, 56.0, 56.0, 56.0, 58.0, 57.0, 56.0, 57.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 57.0, 57.0, 56.0, 56.0, 57.0, 57.0, 60.0, 57.0], "value": 57.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 99.0, 98.0, 90.0, 90.0, 89.0, 92.0, 92.0, 132.0, 87.0], "value": 95.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 137.0, 150.0, 136.0, 132.0, 135.0, 134.0, 135.0, 132.0, 134.0], "value": 135.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 190.0, 197.0, 193.0, 200.0, 193.0, 184.0, 197.0, 197.0, 194.0], "value": 193.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 79.0, 71.0, 72.0, 72.0, 74.0, 72.0, 72.0, 76.0], "value": 73.9, "unit": "score"}]}]} 02:21:21 INFO - Return code: 0 02:21:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:21:21 INFO - # TBPL SUCCESS # 02:21:21 INFO - Running post-action listener: _resource_record_post_action 02:21:21 INFO - [mozharness: 2017-05-29 09:21:21.406704Z] Finished run-tests step (success) 02:21:21 INFO - Running post-run listener: _resource_record_post_run 02:21:21 INFO - Total resource usage - Wall time: 1257s; CPU: 13.0%; Read bytes: 12288; Write bytes: 401879040; Read time: 292; Write time: 263772 02:21:21 INFO - TinderboxPrint: CPU usage
12.7% 02:21:21 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 292 02:21:21 INFO - TinderboxPrint: I/O write bytes / time
401,879,040 / 263,772 02:21:21 INFO - TinderboxPrint: CPU idle
8,760.2 (87.3%) 02:21:21 INFO - TinderboxPrint: CPU user
1,218.5 (12.1%) 02:21:21 INFO - TinderboxPrint: Swap in / out
0 / 0 02:21:21 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 98217984; Read time: 80; Write time: 78972 02:21:21 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 02:21:21 INFO - run-tests - Wall time: 1242s; CPU: 13.0%; Read bytes: 8192; Write bytes: 303661056; Read time: 212; Write time: 184800 02:21:22 INFO - Running post-run listener: _upload_blobber_files 02:21:22 INFO - Blob upload gear active. 02:21:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:21:22 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 02:21:22 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'] 02:21:22 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 02:21:22 INFO - (blobuploader) - INFO - Open directory for files ... 02:21:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:21:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:21:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:21:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:21:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:21:23 INFO - (blobuploader) - INFO - Done attempting. 02:21:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:21:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:21:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:21:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:21:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:21:30 INFO - (blobuploader) - INFO - Done attempting. 02:21:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:21:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:21:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:21:30 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:21:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:21:30 INFO - (blobuploader) - INFO - Done attempting. 02:21:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:21:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:21:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:21:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:21:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:21:31 INFO - (blobuploader) - INFO - Done attempting. 02:21:31 INFO - (blobuploader) - INFO - Iteration through files over. 02:21:31 INFO - Return code: 0 02:21:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:21:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:21:31 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/be997a447eb617dcb53bc1e18f1825b2f1d365a852c413419a56db0983e1831e6a3633414146767eeca82474be5a3a36510a2ad6819183113ecc38717d87e383", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c2bee4ae30f32ef6901bd6dba13f00d13bec5c52d378d419654927605e34c04fd10d1e799ef5d6a3433a005b0382b2f5d87b1c9db4b14e5cbae75e3b1d1dbcea", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c84277d288db8e3d22eb177d693b348a6bbb89cbc65218babbf4b058e13b52caa92afd3f249f639004d9264b7213d340fd257637f461af0161b613ec7f937523", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fb64460c5388de1a9c3049e697a6f7f689e44ede3eb016498cca962f023f40ba540e6fc0a99bcef5f471bc6ddb54af592b27723b0cee47062ade1be903c66b79"} 02:21:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:21:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:21:31 INFO - Contents: 02:21:31 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/be997a447eb617dcb53bc1e18f1825b2f1d365a852c413419a56db0983e1831e6a3633414146767eeca82474be5a3a36510a2ad6819183113ecc38717d87e383", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c2bee4ae30f32ef6901bd6dba13f00d13bec5c52d378d419654927605e34c04fd10d1e799ef5d6a3433a005b0382b2f5d87b1c9db4b14e5cbae75e3b1d1dbcea", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c84277d288db8e3d22eb177d693b348a6bbb89cbc65218babbf4b058e13b52caa92afd3f249f639004d9264b7213d340fd257637f461af0161b613ec7f937523", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fb64460c5388de1a9c3049e697a6f7f689e44ede3eb016498cca962f023f40ba540e6fc0a99bcef5f471bc6ddb54af592b27723b0cee47062ade1be903c66b79"} 02:21:31 INFO - Running post-run listener: copy_logs_to_upload_dir 02:21:31 INFO - Copying logs to upload dir... 02:21:31 INFO - mkdir: /builds/slave/test/build/upload/logs 02:21:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1347.799541 ========= master_lag: -0.38 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 27 secs) (at 2017-05-29 02:21:29.272986) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-29 02:21:29.280677) ========= 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=ea65d483da93c827905c2090000001f5-1496032186.124567-1132932723 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/be997a447eb617dcb53bc1e18f1825b2f1d365a852c413419a56db0983e1831e6a3633414146767eeca82474be5a3a36510a2ad6819183113ecc38717d87e383", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c2bee4ae30f32ef6901bd6dba13f00d13bec5c52d378d419654927605e34c04fd10d1e799ef5d6a3433a005b0382b2f5d87b1c9db4b14e5cbae75e3b1d1dbcea", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c84277d288db8e3d22eb177d693b348a6bbb89cbc65218babbf4b058e13b52caa92afd3f249f639004d9264b7213d340fd257637f461af0161b613ec7f937523", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fb64460c5388de1a9c3049e697a6f7f689e44ede3eb016498cca962f023f40ba540e6fc0a99bcef5f471bc6ddb54af592b27723b0cee47062ade1be903c66b79"} build_url:https://queue.taskcluster.net/v1/task/TddXRzz_SvuOenppX06GOQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011201 build_url: 'https://queue.taskcluster.net/v1/task/TddXRzz_SvuOenppX06GOQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/be997a447eb617dcb53bc1e18f1825b2f1d365a852c413419a56db0983e1831e6a3633414146767eeca82474be5a3a36510a2ad6819183113ecc38717d87e383", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c2bee4ae30f32ef6901bd6dba13f00d13bec5c52d378d419654927605e34c04fd10d1e799ef5d6a3433a005b0382b2f5d87b1c9db4b14e5cbae75e3b1d1dbcea", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c84277d288db8e3d22eb177d693b348a6bbb89cbc65218babbf4b058e13b52caa92afd3f249f639004d9264b7213d340fd257637f461af0161b613ec7f937523", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fb64460c5388de1a9c3049e697a6f7f689e44ede3eb016498cca962f023f40ba540e6fc0a99bcef5f471bc6ddb54af592b27723b0cee47062ade1be903c66b79"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-29 02:21:29.307802) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-29 02:21:29.308160) ========= 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=ea65d483da93c827905c2090000001f5-1496032186.124567-1132932723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004525 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-29 02:21:29.388893) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-29 02:21:29.389189) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-29 02:21:29.392480) ========= ========= Total master_lag: -0.13 =========