builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-046 starttime: 1496797188.84 results: success (0) revision: 5801aa478de12a62b2b2982659e787fcc4268d67 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-06 17:59:48.840784) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-06 17:59:48.841457) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-06 17:59:48.841741) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-06 17:59:48.922900) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-06 17:59:48.923176) ========= 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=652eb03db935cfc1c15ebda0000001ad-1496789342.373627-1721748896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-06 17:59:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2017-06-06 17:59:49 (46.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.095936 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-06 17:59:49.053485) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-06 17:59:49.053805) ========= 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=652eb03db935cfc1c15ebda0000001ad-1496789342.373627-1721748896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015784 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-06 17:59:49.122058) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-06 17:59:49.122361) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5801aa478de12a62b2b2982659e787fcc4268d67 --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 5801aa478de12a62b2b2982659e787fcc4268d67 --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=652eb03db935cfc1c15ebda0000001ad-1496789342.373627-1721748896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-06 17:59:49,246 truncating revision to first 12 chars 2017-06-06 17:59:49,247 Setting DEBUG logging. 2017-06-06 17:59:49,247 attempt 1/10 2017-06-06 17:59:49,247 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5801aa478de1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-06 17:59:49,707 unpacking tar archive at: mozilla-central-5801aa478de1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.796386 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-06 17:59:49.939640) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-06 17:59:49.939948) ========= script_repo_revision: 5801aa478de12a62b2b2982659e787fcc4268d67 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-06 17:59:49.940313) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-06 17:59:49.940582) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-06 17:59:49.953255) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 52 secs) (at 2017-06-06 17:59:49.953541) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=652eb03db935cfc1c15ebda0000001ad-1496789342.373627-1721748896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:59:50 INFO - MultiFileLogger online at 20170606 17:59:50 in /builds/slave/test 17:59:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 17:59:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:59:50 INFO - {'append_to_log': False, 17:59:50 INFO - 'base_work_dir': '/builds/slave/test', 17:59:50 INFO - 'blob_upload_branch': 'Firefox', 17:59:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:59:50 INFO - 'branch': 'Firefox', 17:59:50 INFO - 'buildbot_json_path': 'buildprops.json', 17:59:50 INFO - 'config_files': ('talos/linux_config.py',), 17:59:50 INFO - 'default_actions': ('clobber', 17:59:50 INFO - 'read-buildbot-config', 17:59:50 INFO - 'download-and-extract', 17:59:50 INFO - 'populate-webroot', 17:59:50 INFO - 'create-virtualenv', 17:59:50 INFO - 'install', 17:59:50 INFO - 'setup-mitmproxy', 17:59:50 INFO - 'run-tests'), 17:59:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:59:50 INFO - 'download_minidump_stackwalk': True, 17:59:50 INFO - 'download_symbols': 'ondemand', 17:59:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:59:50 INFO - 'tooltool.py': '/tools/tooltool.py', 17:59:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:59:50 INFO - '/tools/misc-python/virtualenv.py')}, 17:59:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:59:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:59:50 INFO - 'gecko_profile': False, 17:59:50 INFO - 'gecko_profile_interval': 0, 17:59:50 INFO - 'installer_path': 'installer.exe', 17:59:50 INFO - 'log_level': 'info', 17:59:50 INFO - 'log_name': 'talos', 17:59:50 INFO - 'log_to_console': True, 17:59:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:59:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:59:50 INFO - 'opt_config_files': (), 17:59:50 INFO - 'pip_index': False, 17:59:50 INFO - 'suite': 'dromaeojs-e10s', 17:59:50 INFO - 'system_bits': '32', 17:59:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:59:50 INFO - 'title': 'talos-linux64-ix-046', 17:59:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:59:50 INFO - 'use_talos_json': True, 17:59:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:59:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:59:50 INFO - 'work_dir': 'build'} 17:59:50 INFO - [mozharness: 2017-06-07 00:59:50.181090Z] Running clobber step. 17:59:50 INFO - Running pre-action listener: _resource_record_pre_action 17:59:50 INFO - Running main action method: clobber 17:59:50 INFO - rmtree: /builds/slave/test/build 17:59:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:59:51 INFO - Running post-action listener: _resource_record_post_action 17:59:51 INFO - [mozharness: 2017-06-07 00:59:51.202896Z] Finished clobber step (success) 17:59:51 INFO - [mozharness: 2017-06-07 00:59:51.202998Z] Running read-buildbot-config step. 17:59:51 INFO - Running pre-action listener: _resource_record_pre_action 17:59:51 INFO - Running main action method: read_buildbot_config 17:59:51 INFO - Using buildbot properties: 17:59:51 INFO - { 17:59:51 INFO - "project": "", 17:59:51 INFO - "product": "firefox", 17:59:51 INFO - "who": "kwierso@gmail.com", 17:59:51 INFO - "installer_path": "public/build/target.tar.bz2", 17:59:51 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 17:59:51 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 17:59:51 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 17:59:51 INFO - "stage_platform": "linux64-stylo", 17:59:51 INFO - "basedir": "/builds/slave/test", 17:59:51 INFO - "buildnumber": 141, 17:59:51 INFO - "platform": "ubuntu64_hw_stylo", 17:59:51 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:59:51 INFO - "slavebuilddir": "test", 17:59:51 INFO - "taskId": "ICIPgQnMRlWAkFxwwFUoCA", 17:59:51 INFO - "branch": "mozilla-central", 17:59:51 INFO - "script_repo_revision": "production", 17:59:51 INFO - "revision": "5801aa478de12a62b2b2982659e787fcc4268d67", 17:59:51 INFO - "slavename": "talos-linux64-ix-046", 17:59:51 INFO - "repo_path": "mozilla-central" 17:59:51 INFO - } 17:59:51 INFO - Finding installer, test and symbols from parent task. 17:59:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ICIPgQnMRlWAkFxwwFUoCA'}, attempt #1 17:59:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ICIPgQnMRlWAkFxwwFUoCA'}, attempt #1 17:59:52 INFO - Task dependencies: NRSVz81RQ9iSzTtcJ00cnw 17:59:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw'}, attempt #1 17:59:52 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw/artifacts/public/build/target.tar.bz2 17:59:52 INFO - Set test_url: https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw/artifacts/public/build/test_packages.json 17:59:52 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw/artifacts/public/build/target.crashreporter-symbols.zip 17:59:52 INFO - Running post-action listener: _resource_record_post_action 17:59:52 INFO - [mozharness: 2017-06-07 00:59:52.576878Z] Finished read-buildbot-config step (success) 17:59:52 INFO - [mozharness: 2017-06-07 00:59:52.577096Z] Running download-and-extract step. 17:59:52 INFO - Running pre-action listener: _resource_record_pre_action 17:59:52 INFO - Running main action method: download_and_extract 17:59:52 INFO - mkdir: /builds/slave/test/build/tests 17:59:52 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')]} 17:59:52 INFO - trying https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw/artifacts/public/build/target.test_packages.json 17:59:52 INFO - Downloading https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:59:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:59:53 INFO - Downloaded 989 bytes. 17:59:53 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:59:53 INFO - Using the following test package requirements: 17:59:53 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:59:53 INFO - u'common': [u'target.common.tests.zip'], 17:59:53 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:59:53 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:59:53 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:59:53 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:59:53 INFO - u'mozbase': [u'target.common.tests.zip'], 17:59:53 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:59:53 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:59:53 INFO - u'web-platform': [u'target.common.tests.zip', 17:59:53 INFO - u'target.web-platform.tests.tar.gz'], 17:59:53 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:59:53 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:59:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw/artifacts/public/build/target.common.tests.zip 17:59:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:59:53 INFO - Fetch https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw/artifacts/public/build/target.common.tests.zip into memory 17:59:54 INFO - Content-Length response header: 65110310 17:59:54 INFO - Bytes received: 65110310 18:00:05 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:00:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw/artifacts/public/build/target.common.tests.zip 18:00:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:00:05 INFO - Fetch https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw/artifacts/public/build/target.common.tests.zip into memory 18:00:06 INFO - Content-Length response header: 65110310 18:00:06 INFO - Bytes received: 65110310 18:00:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw/artifacts/public/build/target.talos.tests.zip 18:00:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:00:18 INFO - Fetch https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw/artifacts/public/build/target.talos.tests.zip into memory 18:00:18 INFO - Content-Length response header: 14447563 18:00:18 INFO - Bytes received: 14447563 18:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:00:19 INFO - trying https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw/artifacts/public/build/target.tar.bz2 18:00:19 INFO - Downloading https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:00:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:00:20 INFO - Downloaded 60599533 bytes. 18:00:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw/artifacts/public/build/target.tar.bz2 18:00:20 INFO - mkdir: /builds/slave/test/properties 18:00:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:00:20 INFO - Writing to file /builds/slave/test/properties/build_url 18:00:20 INFO - Contents: 18:00:20 INFO - build_url:https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw/artifacts/public/build/target.tar.bz2 18:00:20 INFO - Running post-action listener: _resource_record_post_action 18:00:20 INFO - Running post-action listener: set_extra_try_arguments 18:00:20 INFO - [mozharness: 2017-06-07 01:00:20.377536Z] Finished download-and-extract step (success) 18:00:20 INFO - [mozharness: 2017-06-07 01:00:20.377632Z] Running populate-webroot step. 18:00:20 INFO - Running pre-action listener: _resource_record_pre_action 18:00:20 INFO - Running main action method: populate_webroot 18:00:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:00:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:00:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:00:20 INFO - '--tppagecycles', 18:00:20 INFO - '7'], 18:00:20 INFO - 'tests': ['tsvgm']}}, 18:00:20 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:00:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:00:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:00:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:00:20 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:00:20 INFO - 'talos_options': ['--disable-e10s'], 18:00:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:00:20 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:00:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:00:20 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:00:20 INFO - 'talos_options': ['--disable-e10s'], 18:00:20 INFO - 'tests': ['damp', 'tps']}, 18:00:20 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:00:20 INFO - 'tests': ['damp', 'tps']}, 18:00:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:00:20 INFO - 'tests': ['dromaeo_dom']}, 18:00:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:00:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:00:20 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 18:00:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:00:20 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:00:20 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:00:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:00:20 INFO - 'tests': ['a11yr', 18:00:20 INFO - 'ts_paint', 18:00:20 INFO - 'tpaint', 18:00:20 INFO - 'sessionrestore', 18:00:20 INFO - 'sessionrestore_no_auto_restore', 18:00:20 INFO - 'tabpaint']}, 18:00:20 INFO - 'other-e10s': {'tests': ['a11yr', 18:00:20 INFO - 'ts_paint', 18:00:20 INFO - 'tpaint', 18:00:20 INFO - 'sessionrestore', 18:00:20 INFO - 'sessionrestore_no_auto_restore', 18:00:20 INFO - 'tabpaint']}, 18:00:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:00:20 INFO - 'ts_paint', 18:00:20 INFO - 'tpaint', 18:00:20 INFO - 'sessionrestore', 18:00:20 INFO - 'sessionrestore_no_auto_restore', 18:00:20 INFO - 'tabpaint']}, 18:00:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:00:20 INFO - 'ts_paint', 18:00:20 INFO - 'tpaint', 18:00:20 INFO - 'sessionrestore', 18:00:20 INFO - 'sessionrestore_no_auto_restore', 18:00:20 INFO - 'tabpaint']}, 18:00:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:00:20 INFO - 'tests': ['a11yr', 18:00:20 INFO - 'ts_paint', 18:00:20 INFO - 'tpaint', 18:00:20 INFO - 'sessionrestore', 18:00:20 INFO - 'sessionrestore_no_auto_restore', 18:00:20 INFO - 'tabpaint']}, 18:00:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:00:20 INFO - 'tests': ['a11yr', 18:00:20 INFO - 'ts_paint', 18:00:20 INFO - 'tpaint', 18:00:20 INFO - 'sessionrestore', 18:00:20 INFO - 'sessionrestore_no_auto_restore', 18:00:20 INFO - 'tabpaint']}, 18:00:20 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 18:00:20 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 18:00:20 INFO - 'bloom_basic_ref']}, 18:00:20 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 18:00:20 INFO - 'talos_options': ['--mitmproxy', 18:00:20 INFO - 'mitmproxy-recording-1.mp', 18:00:20 INFO - '--firstNonBlankPaint'], 18:00:20 INFO - 'tests': ['Quantum_1']}, 18:00:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:00:20 INFO - 'tests': ['tsvgx', 18:00:20 INFO - 'tsvgr_opacity', 18:00:20 INFO - 'tart', 18:00:20 INFO - 'tscrollx', 18:00:20 INFO - 'cart', 18:00:20 INFO - 'tsvg_static']}, 18:00:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:00:20 INFO - 'tsvgr_opacity', 18:00:20 INFO - 'tart', 18:00:20 INFO - 'tscrollx', 18:00:20 INFO - 'cart', 18:00:20 INFO - 'tsvg_static']}, 18:00:20 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:00:20 INFO - 'talos_options': ['--disable-e10s'], 18:00:20 INFO - 'tests': ['tp5o']}, 18:00:20 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:00:20 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:00:20 INFO - 'talos_options': ['--disable-e10s', 18:00:20 INFO - '--xperf_path', 18:00:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:00:20 INFO - 'tests': ['tp5n']}, 18:00:20 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:00:20 INFO - 'talos_options': ['--xperf_path', 18:00:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:00:20 INFO - 'tests': ['tp5n']}}, 18:00:20 INFO - 'talos.zip': {'path': '', 18:00:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:00:20 INFO - Running post-action listener: _resource_record_post_action 18:00:20 INFO - [mozharness: 2017-06-07 01:00:20.391893Z] Finished populate-webroot step (success) 18:00:20 INFO - [mozharness: 2017-06-07 01:00:20.391987Z] Running create-virtualenv step. 18:00:20 INFO - Running pre-action listener: _resource_record_pre_action 18:00:20 INFO - Running main action method: create_virtualenv 18:00:20 INFO - Creating virtualenv /builds/slave/test/build/venv 18:00:20 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 18:00:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:00:20 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:00:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:00:20 INFO - Using real prefix '/usr' 18:00:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:00:20 INFO - Installing distribute.............................................................................................................................................................................................done. 18:00:22 INFO - Installing pip.................done. 18:00:22 INFO - Return code: 0 18:00:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:00:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:00:23 INFO - Reading from file tmpfile_stdout 18:00:23 INFO - Output received: 18:00:23 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) 18:00:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18: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')]} 18:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18: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')]} 18:00:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2205a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a99a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a7140>, '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 0x23a7a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a7ed0>, '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': '652eb03db935cfc1c15ebda0000001ad-1496789342.373627-1721748896', '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 18: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', 'pip>=1.5'] in /builds/slave/test/build 18: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 pip>=1.5 18:00:23 INFO - Using env: {'DISPLAY': ':0', 18:00:23 INFO - 'HOME': '/home/cltbld', 18:00:23 INFO - 'LANG': 'en_US.UTF-8', 18:00:23 INFO - 'LANGUAGE': 'en_US:en', 18:00:23 INFO - 'LOGNAME': 'cltbld', 18:00:23 INFO - 'MAIL': '/var/mail/cltbld', 18:00:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:23 INFO - 'MOZ_NO_REMOTE': '1', 18:00:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:23 INFO - 'NO_EM_RESTART': '1', 18:00:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:23 INFO - 'PWD': '/builds/slave/test', 18:00:23 INFO - 'SHELL': '/bin/bash', 18:00:23 INFO - 'SHLVL': '1', 18:00:23 INFO - 'TERM': 'linux', 18:00:23 INFO - 'TMOUT': '86400', 18:00:23 INFO - 'USER': 'cltbld', 18:00:23 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1496789342.373627-1721748896', 18:00:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:23 INFO - '_': '/tools/buildbot/bin/python'} 18:00:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:23 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 18:00:23 INFO - Cleaning up... 18:00:23 INFO - Return code: 0 18:00:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18: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')]} 18:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18: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')]} 18:00:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18: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', '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 0x202b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2205a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a99a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a7140>, '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 0x23a7a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a7ed0>, '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': '652eb03db935cfc1c15ebda0000001ad-1496789342.373627-1721748896', '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 18: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', 'psutil>=3.1.1'] in /builds/slave/test/build 18: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 psutil>=3.1.1 18:00:23 INFO - Using env: {'DISPLAY': ':0', 18:00:23 INFO - 'HOME': '/home/cltbld', 18:00:23 INFO - 'LANG': 'en_US.UTF-8', 18:00:23 INFO - 'LANGUAGE': 'en_US:en', 18:00:23 INFO - 'LOGNAME': 'cltbld', 18:00:23 INFO - 'MAIL': '/var/mail/cltbld', 18:00:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:23 INFO - 'MOZ_NO_REMOTE': '1', 18:00:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:23 INFO - 'NO_EM_RESTART': '1', 18:00:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:23 INFO - 'PWD': '/builds/slave/test', 18:00:23 INFO - 'SHELL': '/bin/bash', 18:00:23 INFO - 'SHLVL': '1', 18:00:23 INFO - 'TERM': 'linux', 18:00:23 INFO - 'TMOUT': '86400', 18:00:23 INFO - 'USER': 'cltbld', 18:00:23 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1496789342.373627-1721748896', 18:00:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:23 INFO - '_': '/tools/buildbot/bin/python'} 18:00:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:23 INFO - Downloading/unpacking psutil>=3.1.1 18:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:00:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:00:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:00:24 INFO - Installing collected packages: psutil 18:00:24 INFO - Running setup.py install for psutil 18:00:24 INFO - building 'psutil._psutil_linux' extension 18:00:24 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 18:00:25 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 18:00:25 INFO - building 'psutil._psutil_posix' extension 18:00:25 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 18:00:25 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 18:00:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:00:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:00:25 INFO - Successfully installed psutil 18:00:25 INFO - Cleaning up... 18:00:25 INFO - Return code: 0 18:00:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:00:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:00:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:25 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 0x202b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2205a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a99a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a7140>, '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 0x23a7a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a7ed0>, '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': '652eb03db935cfc1c15ebda0000001ad-1496789342.373627-1721748896', '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 18:00:25 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 18:00:25 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 18:00:25 INFO - Using env: {'DISPLAY': ':0', 18:00:25 INFO - 'HOME': '/home/cltbld', 18:00:25 INFO - 'LANG': 'en_US.UTF-8', 18:00:25 INFO - 'LANGUAGE': 'en_US:en', 18:00:25 INFO - 'LOGNAME': 'cltbld', 18:00:25 INFO - 'MAIL': '/var/mail/cltbld', 18:00:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:25 INFO - 'MOZ_NO_REMOTE': '1', 18:00:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:25 INFO - 'NO_EM_RESTART': '1', 18:00:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:25 INFO - 'PWD': '/builds/slave/test', 18:00:25 INFO - 'SHELL': '/bin/bash', 18:00:25 INFO - 'SHLVL': '1', 18:00:25 INFO - 'TERM': 'linux', 18:00:25 INFO - 'TMOUT': '86400', 18:00:25 INFO - 'USER': 'cltbld', 18:00:25 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1496789342.373627-1721748896', 18:00:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:25 INFO - '_': '/tools/buildbot/bin/python'} 18:00:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:00:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:00:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:00:26 INFO - Installing collected packages: mozsystemmonitor 18:00:26 INFO - Running setup.py install for mozsystemmonitor 18:00:26 INFO - Successfully installed mozsystemmonitor 18:00:26 INFO - Cleaning up... 18:00:26 INFO - Return code: 0 18:00:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:00:26 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')]} 18:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:26 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')]} 18:00:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:26 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 0x202b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2205a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a99a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a7140>, '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 0x23a7a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a7ed0>, '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': '652eb03db935cfc1c15ebda0000001ad-1496789342.373627-1721748896', '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 18:00:26 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 18:00:26 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 18:00:26 INFO - Using env: {'DISPLAY': ':0', 18:00:26 INFO - 'HOME': '/home/cltbld', 18:00:26 INFO - 'LANG': 'en_US.UTF-8', 18:00:26 INFO - 'LANGUAGE': 'en_US:en', 18:00:26 INFO - 'LOGNAME': 'cltbld', 18:00:26 INFO - 'MAIL': '/var/mail/cltbld', 18:00:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:26 INFO - 'MOZ_NO_REMOTE': '1', 18:00:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:26 INFO - 'NO_EM_RESTART': '1', 18:00:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:26 INFO - 'PWD': '/builds/slave/test', 18:00:26 INFO - 'SHELL': '/bin/bash', 18:00:26 INFO - 'SHLVL': '1', 18:00:26 INFO - 'TERM': 'linux', 18:00:26 INFO - 'TMOUT': '86400', 18:00:26 INFO - 'USER': 'cltbld', 18:00:26 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1496789342.373627-1721748896', 18:00:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:26 INFO - '_': '/tools/buildbot/bin/python'} 18:00:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:27 INFO - Downloading/unpacking jsonschema==2.5.1 18:00:27 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 18:00:27 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 18:00:27 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 18:00:27 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 18:00:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:00:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:28 INFO - Downloading functools32-3.2.3-2.tar.gz 18:00:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:00:28 INFO - warning: no files found matching '*.txt' 18:00:28 INFO - no previously-included directories found matching 'build' 18:00:28 INFO - no previously-included directories found matching 'dist' 18:00:28 INFO - no previously-included directories found matching '.git*' 18:00:28 INFO - Installing collected packages: jsonschema, functools32 18:00:28 INFO - Running setup.py install for functools32 18:00:28 INFO - warning: no files found matching '*.txt' 18:00:28 INFO - no previously-included directories found matching 'build' 18:00:28 INFO - no previously-included directories found matching 'dist' 18:00:28 INFO - no previously-included directories found matching '.git*' 18:00:28 INFO - Successfully installed jsonschema functools32 18:00:28 INFO - Cleaning up... 18:00:28 INFO - Return code: 0 18:00:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:00:28 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')]} 18:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:28 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')]} 18:00:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:28 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 0x202b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2205a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a99a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a7140>, '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 0x23a7a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a7ed0>, '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': '652eb03db935cfc1c15ebda0000001ad-1496789342.373627-1721748896', '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 18:00:28 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 18:00:28 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 18:00:28 INFO - Using env: {'DISPLAY': ':0', 18:00:28 INFO - 'HOME': '/home/cltbld', 18:00:28 INFO - 'LANG': 'en_US.UTF-8', 18:00:28 INFO - 'LANGUAGE': 'en_US:en', 18:00:28 INFO - 'LOGNAME': 'cltbld', 18:00:28 INFO - 'MAIL': '/var/mail/cltbld', 18:00:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:28 INFO - 'MOZ_NO_REMOTE': '1', 18:00:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:28 INFO - 'NO_EM_RESTART': '1', 18:00:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:28 INFO - 'PWD': '/builds/slave/test', 18:00:28 INFO - 'SHELL': '/bin/bash', 18:00:28 INFO - 'SHLVL': '1', 18:00:28 INFO - 'TERM': 'linux', 18:00:28 INFO - 'TMOUT': '86400', 18:00:28 INFO - 'USER': 'cltbld', 18:00:28 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1496789342.373627-1721748896', 18:00:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:28 INFO - '_': '/tools/buildbot/bin/python'} 18:00:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:00:28 INFO - Cleaning up... 18:00:28 INFO - Return code: 0 18:00:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:00:28 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')]} 18:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:28 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')]} 18:00:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:28 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 0x202b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2205a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a99a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a7140>, '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 0x23a7a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a7ed0>, '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': '652eb03db935cfc1c15ebda0000001ad-1496789342.373627-1721748896', '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 18:00:28 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 18:00:28 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 18:00:28 INFO - Using env: {'DISPLAY': ':0', 18:00:28 INFO - 'HOME': '/home/cltbld', 18:00:28 INFO - 'LANG': 'en_US.UTF-8', 18:00:28 INFO - 'LANGUAGE': 'en_US:en', 18:00:28 INFO - 'LOGNAME': 'cltbld', 18:00:28 INFO - 'MAIL': '/var/mail/cltbld', 18:00:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:28 INFO - 'MOZ_NO_REMOTE': '1', 18:00:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:28 INFO - 'NO_EM_RESTART': '1', 18:00:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:28 INFO - 'PWD': '/builds/slave/test', 18:00:28 INFO - 'SHELL': '/bin/bash', 18:00:28 INFO - 'SHLVL': '1', 18:00:28 INFO - 'TERM': 'linux', 18:00:28 INFO - 'TMOUT': '86400', 18:00:28 INFO - 'USER': 'cltbld', 18:00:28 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1496789342.373627-1721748896', 18:00:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:28 INFO - '_': '/tools/buildbot/bin/python'} 18:00:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:28 INFO - Downloading/unpacking blobuploader==1.2.4 18:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:29 INFO - Downloading blobuploader-1.2.4.tar.gz 18:00:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:00:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:00:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:30 INFO - Downloading docopt-0.6.1.tar.gz 18:00:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:00:30 INFO - Installing collected packages: blobuploader, requests, docopt 18:00:30 INFO - Running setup.py install for blobuploader 18:00:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:00:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:00:30 INFO - Running setup.py install for requests 18:00:31 INFO - Running setup.py install for docopt 18:00:31 INFO - Successfully installed blobuploader requests docopt 18:00:31 INFO - Cleaning up... 18:00:31 INFO - Return code: 0 18:00:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:00:31 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')]} 18:00:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:31 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')]} 18:00:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:31 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 0x202b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2205a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a99a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a7140>, '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 0x23a7a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a7ed0>, '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': '652eb03db935cfc1c15ebda0000001ad-1496789342.373627-1721748896', '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 18:00:31 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 18:00:31 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 18:00:31 INFO - Using env: {'DISPLAY': ':0', 18:00:31 INFO - 'HOME': '/home/cltbld', 18:00:31 INFO - 'LANG': 'en_US.UTF-8', 18:00:31 INFO - 'LANGUAGE': 'en_US:en', 18:00:31 INFO - 'LOGNAME': 'cltbld', 18:00:31 INFO - 'MAIL': '/var/mail/cltbld', 18:00:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:31 INFO - 'MOZ_NO_REMOTE': '1', 18:00:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:31 INFO - 'NO_EM_RESTART': '1', 18:00:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:31 INFO - 'PWD': '/builds/slave/test', 18:00:31 INFO - 'SHELL': '/bin/bash', 18:00:31 INFO - 'SHLVL': '1', 18:00:31 INFO - 'TERM': 'linux', 18:00:31 INFO - 'TMOUT': '86400', 18:00:31 INFO - 'USER': 'cltbld', 18:00:31 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1496789342.373627-1721748896', 18:00:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:31 INFO - '_': '/tools/buildbot/bin/python'} 18:00:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:00:31 INFO - Running setup.py (path:/tmp/pip-6ircHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:00:31 INFO - Running setup.py (path:/tmp/pip-xlqApA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:00:31 INFO - Running setup.py (path:/tmp/pip-is0GWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:00:31 INFO - Running setup.py (path:/tmp/pip-TSeYAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:00:31 INFO - Running setup.py (path:/tmp/pip-pv7C2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:00:31 INFO - Running setup.py (path:/tmp/pip-pgXZF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:00:31 INFO - Running setup.py (path:/tmp/pip-xEHOEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:00:31 INFO - Running setup.py (path:/tmp/pip-Yd35dZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:00:31 INFO - Running setup.py (path:/tmp/pip-Ak1Z2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:00:32 INFO - Running setup.py (path:/tmp/pip-2NCoES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:00:32 INFO - Running setup.py (path:/tmp/pip-SOcyut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:00:32 INFO - Running setup.py (path:/tmp/pip-usrsk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:00:32 INFO - Running setup.py (path:/tmp/pip-F6YYEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:00:32 INFO - Running setup.py (path:/tmp/pip-y7Yea1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:00:32 INFO - Running setup.py (path:/tmp/pip-3sfH4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:00:32 INFO - Running setup.py (path:/tmp/pip-a4Tqq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:00:32 INFO - Running setup.py (path:/tmp/pip-5j0Zft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:00:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:00:32 INFO - Running setup.py install for manifestparser 18:00:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:00:32 INFO - Running setup.py install for mozcrash 18:00:32 INFO - Running setup.py install for mozdebug 18:00:32 INFO - Running setup.py install for mozdevice 18:00:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:00:33 INFO - Running setup.py install for mozfile 18:00:33 INFO - Running setup.py install for mozhttpd 18:00:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:00:33 INFO - Running setup.py install for mozinfo 18:00:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:00:33 INFO - Running setup.py install for mozInstall 18:00:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:00:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:00:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:00:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:00:33 INFO - Running setup.py install for mozleak 18:00:33 INFO - Running setup.py install for mozlog 18:00:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:00:33 INFO - Running setup.py install for moznetwork 18:00:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:00:33 INFO - Running setup.py install for mozprocess 18:00:33 INFO - Running setup.py install for mozprofile 18:00:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:00:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:00:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:00:33 INFO - Running setup.py install for mozrunner 18:00:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:00:34 INFO - Running setup.py install for mozscreenshot 18:00:34 INFO - Running setup.py install for moztest 18:00:34 INFO - Running setup.py install for mozversion 18:00:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:00:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:00:34 INFO - Cleaning up... 18:00:34 INFO - Return code: 0 18:00:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:00:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:00:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:34 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 0x202b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2205a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a99a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a7140>, '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 0x23a7a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a7ed0>, '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': '652eb03db935cfc1c15ebda0000001ad-1496789342.373627-1721748896', '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 18:00:34 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 18:00:34 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 18:00:34 INFO - Using env: {'DISPLAY': ':0', 18:00:34 INFO - 'HOME': '/home/cltbld', 18:00:34 INFO - 'LANG': 'en_US.UTF-8', 18:00:34 INFO - 'LANGUAGE': 'en_US:en', 18:00:34 INFO - 'LOGNAME': 'cltbld', 18:00:34 INFO - 'MAIL': '/var/mail/cltbld', 18:00:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:34 INFO - 'MOZ_NO_REMOTE': '1', 18:00:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:34 INFO - 'NO_EM_RESTART': '1', 18:00:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:34 INFO - 'PWD': '/builds/slave/test', 18:00:34 INFO - 'SHELL': '/bin/bash', 18:00:34 INFO - 'SHLVL': '1', 18:00:34 INFO - 'TERM': 'linux', 18:00:34 INFO - 'TMOUT': '86400', 18:00:34 INFO - 'USER': 'cltbld', 18:00:34 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1496789342.373627-1721748896', 18:00:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:34 INFO - '_': '/tools/buildbot/bin/python'} 18:00:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:00:34 INFO - Running setup.py (path:/tmp/pip-XVkzro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:00:34 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)) 18:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:00:34 INFO - Running setup.py (path:/tmp/pip-5ghks9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:00:34 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)) 18:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:00:34 INFO - Running setup.py (path:/tmp/pip-fNtFm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:00:34 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)) 18:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:00:34 INFO - Running setup.py (path:/tmp/pip-DHY_Xe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:00:34 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)) 18:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:00:34 INFO - Running setup.py (path:/tmp/pip-Wnj9Og-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:00:35 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)) 18:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:00:35 INFO - Running setup.py (path:/tmp/pip-W6fawp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:00:35 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)) 18:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:00:35 INFO - Running setup.py (path:/tmp/pip-yxt016-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:00:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:00:35 INFO - Running setup.py (path:/tmp/pip-IwgseQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:00:35 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)) 18:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:00:35 INFO - Running setup.py (path:/tmp/pip-7TomMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:00:35 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)) 18:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:00:35 INFO - Running setup.py (path:/tmp/pip-5y7sAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:00:35 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)) 18:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:00:35 INFO - Running setup.py (path:/tmp/pip-fcHT3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:00:35 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)) 18:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:00:35 INFO - Running setup.py (path:/tmp/pip-8qjZZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:00:35 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)) 18:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:00:35 INFO - Running setup.py (path:/tmp/pip-BFpGrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:00:35 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)) 18:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:00:35 INFO - Running setup.py (path:/tmp/pip-FNs024-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:00:35 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)) 18:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:00:35 INFO - Running setup.py (path:/tmp/pip-DT7nEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:00:35 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)) 18:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:00:35 INFO - Running setup.py (path:/tmp/pip-UOl_Vc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:00:35 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)) 18:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:00:35 INFO - Running setup.py (path:/tmp/pip-61Hkt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:00:35 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)) 18:00:35 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)) 18:00:35 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)) 18:00:35 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)) 18:00:35 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)) 18:00:35 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)) 18:00:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:00:35 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 18:00:35 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 18:00:35 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 18:00:35 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 18:00:36 INFO - Downloading blessings-1.6.tar.gz 18:00:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:00:37 INFO - Installing collected packages: blessings 18:00:37 INFO - Running setup.py install for blessings 18:00:37 INFO - Successfully installed blessings 18:00:37 INFO - Cleaning up... 18:00:37 INFO - Return code: 0 18:00:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:00:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:00:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:00:37 INFO - Reading from file tmpfile_stdout 18:00:37 INFO - Current package versions: 18:00:37 INFO - argparse == 1.2.1 18:00:37 INFO - blessings == 1.6 18:00:37 INFO - blobuploader == 1.2.4 18:00:37 INFO - docopt == 0.6.1 18:00:37 INFO - functools32 == 3.2.3-2 18:00:37 INFO - jsonschema == 2.5.1 18:00:37 INFO - manifestparser == 1.1 18:00:37 INFO - mozInstall == 1.12 18:00:37 INFO - mozcrash == 1.0 18:00:37 INFO - mozdebug == 0.1 18:00:37 INFO - mozdevice == 0.51 18:00:37 INFO - mozfile == 1.2 18:00:37 INFO - mozhttpd == 0.7 18:00:37 INFO - mozinfo == 0.10 18:00:37 INFO - mozleak == 0.1 18:00:37 INFO - mozlog == 3.4 18:00:37 INFO - moznetwork == 0.27 18:00:37 INFO - mozprocess == 0.25 18:00:37 INFO - mozprofile == 0.28 18:00:37 INFO - mozrunner == 6.13 18:00:37 INFO - mozscreenshot == 0.1 18:00:37 INFO - mozsystemmonitor == 0.3 18:00:37 INFO - moztest == 0.8 18:00:37 INFO - mozversion == 1.4 18:00:37 INFO - psutil == 3.1.1 18:00:37 INFO - requests == 1.2.3 18:00:37 INFO - wsgiref == 0.1.2 18:00:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:00:37 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')]} 18:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:37 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')]} 18:00:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:37 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 0x202b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2205a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a99a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a7140>, '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 0x23a7a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a7ed0>, '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': '652eb03db935cfc1c15ebda0000001ad-1496789342.373627-1721748896', '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 18:00:37 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 18:00:37 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 18:00:37 INFO - Using env: {'DISPLAY': ':0', 18:00:37 INFO - 'HOME': '/home/cltbld', 18:00:37 INFO - 'LANG': 'en_US.UTF-8', 18:00:37 INFO - 'LANGUAGE': 'en_US:en', 18:00:37 INFO - 'LOGNAME': 'cltbld', 18:00:37 INFO - 'MAIL': '/var/mail/cltbld', 18:00:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:37 INFO - 'MOZ_NO_REMOTE': '1', 18:00:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:37 INFO - 'NO_EM_RESTART': '1', 18:00:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:37 INFO - 'PWD': '/builds/slave/test', 18:00:37 INFO - 'SHELL': '/bin/bash', 18:00:37 INFO - 'SHLVL': '1', 18:00:37 INFO - 'TERM': 'linux', 18:00:37 INFO - 'TMOUT': '86400', 18:00:37 INFO - 'USER': 'cltbld', 18:00:37 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1496789342.373627-1721748896', 18:00:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:37 INFO - '_': '/tools/buildbot/bin/python'} 18:00:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:37 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)) 18:00:37 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)) 18:00:37 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)) 18:00:37 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)) 18:00:37 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)) 18:00:37 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)) 18:00:37 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)) 18:00:37 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)) 18:00:37 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)) 18:00:37 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:00:37 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 18:00:37 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 18:00:37 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 18:00:37 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 18:00:38 INFO - Downloading marionette_driver-1.4.0.tar.gz 18:00:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 18:00:38 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)) 18:00:38 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)) 18:00:38 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)) 18:00:38 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)) 18:00:38 INFO - Installing collected packages: marionette-driver 18:00:38 INFO - Running setup.py install for marionette-driver 18:00:38 INFO - Successfully installed marionette-driver 18:00:38 INFO - Cleaning up... 18:00:38 INFO - Return code: 0 18:00:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:00:38 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')]} 18:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:38 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')]} 18:00:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:38 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 0x202b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2205a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a99a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a7140>, '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 0x23a7a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a7ed0>, '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': '652eb03db935cfc1c15ebda0000001ad-1496789342.373627-1721748896', '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 18:00:38 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 18:00:38 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 18:00:38 INFO - Using env: {'DISPLAY': ':0', 18:00:38 INFO - 'HOME': '/home/cltbld', 18:00:38 INFO - 'LANG': 'en_US.UTF-8', 18:00:38 INFO - 'LANGUAGE': 'en_US:en', 18:00:38 INFO - 'LOGNAME': 'cltbld', 18:00:38 INFO - 'MAIL': '/var/mail/cltbld', 18:00:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:38 INFO - 'MOZ_NO_REMOTE': '1', 18:00:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:38 INFO - 'NO_EM_RESTART': '1', 18:00:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:38 INFO - 'PWD': '/builds/slave/test', 18:00:38 INFO - 'SHELL': '/bin/bash', 18:00:38 INFO - 'SHLVL': '1', 18:00:38 INFO - 'TERM': 'linux', 18:00:38 INFO - 'TMOUT': '86400', 18:00:38 INFO - 'USER': 'cltbld', 18:00:38 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1496789342.373627-1721748896', 18:00:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:38 INFO - '_': '/tools/buildbot/bin/python'} 18:00:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:00:39 INFO - Cleaning up... 18:00:39 INFO - Return code: 0 18:00:39 INFO - Running post-action listener: _resource_record_post_action 18:00:39 INFO - Running post-action listener: _start_resource_monitoring 18:00:39 INFO - Starting resource monitoring. 18:00:39 INFO - [mozharness: 2017-06-07 01:00:39.209134Z] Finished create-virtualenv step (success) 18:00:39 INFO - [mozharness: 2017-06-07 01:00:39.209678Z] Running install step. 18:00:39 INFO - Running pre-action listener: _resource_record_pre_action 18:00:39 INFO - Running main action method: install 18:00:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:00:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:00:39 INFO - Reading from file tmpfile_stdout 18:00:39 INFO - Detecting whether we're running mozinstall >=1.0... 18:00:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:00:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:00:39 INFO - Reading from file tmpfile_stdout 18:00:39 INFO - Output received: 18:00:39 INFO - Usage: mozinstall [options] installer 18:00:39 INFO - Options: 18:00:39 INFO - -h, --help show this help message and exit 18:00:39 INFO - -d DEST, --destination=DEST 18:00:39 INFO - Directory to install application into. [default: 18:00:39 INFO - "/builds/slave/test"] 18:00:39 INFO - --app=APP Application being installed. [default: firefox] 18:00:39 INFO - mkdir: /builds/slave/test/build/application 18:00:39 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'] 18:00:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:00:56 INFO - Reading from file tmpfile_stdout 18:00:56 INFO - Output received: 18:00:56 INFO - /builds/slave/test/build/application/firefox/firefox 18:00:56 INFO - Running post-action listener: _resource_record_post_action 18:00:56 INFO - [mozharness: 2017-06-07 01:00:56.952516Z] Finished install step (success) 18:00:56 INFO - [mozharness: 2017-06-07 01:00:56.952743Z] Running setup-mitmproxy step. 18:00:56 INFO - Running pre-action listener: _resource_record_pre_action 18:00:56 INFO - Running main action method: setup_mitmproxy 18:00:56 INFO - Skipping: mitmproxy is not required 18:00:56 INFO - Running post-action listener: _resource_record_post_action 18:00:56 INFO - [mozharness: 2017-06-07 01:00:56.953260Z] Finished setup-mitmproxy step (success) 18:00:56 INFO - [mozharness: 2017-06-07 01:00:56.953486Z] Running run-tests step. 18:00:56 INFO - Running pre-action listener: _resource_record_pre_action 18:00:56 INFO - Running main action method: run_tests 18:00:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:00:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:00:56 INFO - Python 2.7.3 18:00:56 INFO - Return code: 0 18:00:56 INFO - grabbing minidump binary from tooltool 18:00:56 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')]} 18:00:56 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 0x23a7140>, '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 0x23a7a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a7ed0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:00:56 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 18:00:56 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 18:00:56 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 18:00:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:00:57 INFO - Return code: 0 18:00:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:00:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:00:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:00:57 INFO - ENV: RUST_BACKTRACE is now 1 18:00:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:00:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:00:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 18:00:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 18:00:57 INFO - Using env: {'DISPLAY': ':0', 18:00:57 INFO - 'HOME': '/home/cltbld', 18:00:57 INFO - 'LANG': 'en_US.UTF-8', 18:00:57 INFO - 'LANGUAGE': 'en_US:en', 18:00:57 INFO - 'LOGNAME': 'cltbld', 18:00:57 INFO - 'MAIL': '/var/mail/cltbld', 18:00:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:00:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:00:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:57 INFO - 'MOZ_NO_REMOTE': '1', 18:00:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:00:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:57 INFO - 'NO_EM_RESTART': '1', 18:00:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:57 INFO - 'PWD': '/builds/slave/test', 18:00:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:00:57 INFO - 'RUST_BACKTRACE': '1', 18:00:57 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:00:57 INFO - 'SHELL': '/bin/bash', 18:00:57 INFO - 'SHLVL': '1', 18:00:57 INFO - 'TERM': 'linux', 18:00:57 INFO - 'TMOUT': '86400', 18:00:57 INFO - 'USER': 'cltbld', 18:00:57 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1496789342.373627-1721748896', 18:00:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:57 INFO - '_': '/tools/buildbot/bin/python'} 18:00:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 18:00:57 INFO - mozversion application_buildid: 20170607001930 18:00:57 INFO - mozversion application_changeset: 5801aa478de12a62b2b2982659e787fcc4268d67 18:00:57 INFO - mozversion application_display_name: Nightly 18:00:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:00:57 INFO - mozversion application_name: Firefox 18:00:57 INFO - mozversion application_remotingname: firefox 18:00:57 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:00:57 INFO - mozversion application_vendor: Mozilla 18:00:57 INFO - mozversion application_version: 55.0a1 18:00:57 INFO - mozversion platform_buildid: 20170607001930 18:00:57 INFO - mozversion platform_changeset: 5801aa478de12a62b2b2982659e787fcc4268d67 18:00:57 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:00:57 INFO - mozversion platform_version: 55.0a1 18:00:57 INFO - using testdate: 1496797257 18:00:57 INFO - actual date: 1496797257 18:00:57 INFO - starting webserver on 'localhost:56207' 18:00:57 INFO - SUITE-START | Running 2 tests 18:00:57 INFO - TEST-START | dromaeo_css 18:00:57 INFO - operating with platform_type : linux_ 18:00:57 INFO - Initialising browser for dromaeo_css test... 18:00:57 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56207/getInfo.html -profile /tmp/tmpC9sbno/profile 18:00:57 INFO - TEST-INFO | started process 12229 (/builds/slave/test/build/application/firefox/firefox http://localhost:56207/getInfo.html) 18:01:32 INFO - TEST-INFO | 12229: killed by SIGTERM 18:01:32 INFO - Browser initialized. 18:01:32 INFO - Running cycle 1/1 for dromaeo_css test... 18:01:32 INFO - TEST-INFO | started process 12457 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC9sbno/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:01:44 INFO - PID 12457 | RSS: Main: 187998208 18:01:44 INFO - PID 12457 | 18:04:44 INFO - PID 12457 | Cycle 1(1): loaded http://localhost:56207/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56207/tests/dromaeo/cssquery-ext.html) 18:04:46 INFO - PID 12457 | RSS: Main: 185200640 18:04:46 INFO - PID 12457 | 18:07:48 INFO - PID 12457 | Cycle 1(1): loaded http://localhost:56207/tests/dromaeo/cssquery-ext.html (next: http://localhost:56207/tests/dromaeo/cssquery-jquery.html) 18:07:48 INFO - PID 12457 | RSS: Main: 189100032 18:07:48 INFO - PID 12457 | 18:10:50 INFO - PID 12457 | Cycle 1(1): loaded http://localhost:56207/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56207/tests/dromaeo/cssquery-mootools.html) 18:10:51 INFO - PID 12457 | RSS: Main: 187207680 18:10:51 INFO - PID 12457 | 18:13:52 INFO - PID 12457 | Cycle 1(1): loaded http://localhost:56207/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56207/tests/dromaeo/cssquery-prototype.html) 18:13:53 INFO - PID 12457 | RSS: Main: 191442944 18:13:53 INFO - PID 12457 | 18:16:56 INFO - PID 12457 | Cycle 1(1): loaded http://localhost:56207/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56207/tests/dromaeo/cssquery-yui.html) 18:16:56 INFO - PID 12457 | RSS: Main: 189120512 18:16:57 INFO - PID 12457 | 18:19:58 INFO - PID 12457 | Cycle 1(1): loaded http://localhost:56207/tests/dromaeo/cssquery-yui.html (next: http://localhost:56207/tests/dromaeo/cssquery-dojo.html) 18:19:59 INFO - PID 12457 | RSS: Main: 190910464 18:19:59 INFO - PID 12457 | 18:19:59 INFO - PID 12457 | __start_tp_report 18:19:59 INFO - PID 12457 | _x_x_mozilla_page_load 18:19:59 INFO - PID 12457 | _x_x_mozilla_page_load_details 18:19:59 INFO - PID 12457 | |i|pagename|runs| 18:19:59 INFO - PID 12457 | |0;dojo.html;3075.7231849133573;3098.519729441937;3103.6120484939383;3115.1121930249883;3125.3436778276573;5873.148393482942;5965;5977.760889564418;5981.162637230791;6025.3070896846875;5940.3762604926505;5986.521078313735;6016;6031.72857221425;6052.818415447544;5454.236406903036;5528.55771538277;5536.197251398545;5576.721163941807;5577.749001294951;5624.240727501796;5644.3508996465525;5677.886442271152;5687.289088863892;5692.288463942007;5442.537384322337;5454.754536045887;5525.281713377275;5555.333359996806;5573.303337082885;5522.144067669517;5547.667139971614;5547.72261386933;5554.444555544414;5594.160875868612;5521.5306698930635;5528.419515950807;5533.363663178746;5534.861628459281;5539.501444869981;5825.271841019872;5917.970410147922;5971.193888824996;6022.187004754346;6024.427679370453;6375.808725738235;6381.553291269613;6443.613383197023;6474.805755827333;6513.576617519846;6549.6070235786;6577.638229897354;6588.769393071268;6589.967050164766;6593.175853018372;5931.436513531207;5978.611390259619;6027.126066720301;6029.065494848305;6038.486728628028;6489.253735820346;6502.284748677642;6564.934350656527;6590.077389165424;6590.80227593173;6172.22847144107;6178.598391104564;6242.219722534684;6321.873562528724;6345;6356.269029061625;6368.713407896656;6401.071844582602;6407.871842563122;6409.935900641027;6176.69116544171;6413.390727880844;6419.1334169887405;6422.582532135396;6431.2604050533855;6292.4966002719675;6378.075179099004;6427.517936154807;6435.131257280301;6462.289148193695;5259.605529585297;5264.999650066475;5264.999650066475;5275.208718692227;5280.287161233185;4482.260427029569;4498.415206023262;4499.932501012488;4526;4527;5577.191307260506;5638.746256418471;5641.717914104361;5686.947914635805;5731.598788084794;6498.350164983558;6571.835704107436;6575.342465753386;6586.670666466657;6602.240742314695;5680.5455563554815;5685.545156387479;5695.060315048054;5720.885582288331;5734.569907256889;5422.566194704415;5515.007298686275;5602.915956260659;5618.101103823368;5621.915671264935;6133.202683651186;6185.783497577563;6194.690265486798;6199.039148931923;6225.3774622537385;6430.582012169194;6447.967760161357;6494.837629059311;6502.284748677736;6515;6236.750529978932;6255.437010669061;6272.2159730033745;6299.6535190564955;6303.810885673437;6141.969290153521;6148.3236843948025;6195.566310358232;6235.844103897439;6239.96880015597;6568.277489476058;6576.079348891255;6576.638284894377;6581.506387020897;6597.241317248578;6069.969650151721;6087.178230938766;6142.600730952474;6324.810255692337;6325.778597749057;6232.657203853832;6274.905876411766;6281.246250449975;6287.779927702509;6297.937020629735;5976.133460648269;6000.039993601003;6038.6678732670125;6162.352952939877;6165.506759459322;6298.464630506458;6310.463610593151;6340.778072767431;6365.777197798055;6371.617702937839;6173.722182501888;6182;6187.84530386744;6201.472874805692;6209.813705588839 18:19:59 INFO - PID 12457 | |1;ext.html;734.9081364829397;777.3586790897509;799.8240387114836;1143.2168964259488;1149.5574203931494;35153.47269790955;35698;35742.64257357429;35759.82120089399;35771.821140894324;37221.441678374846;37697.434538481946;37770.24459510815;37792.86621401362;37797;7196.460265480084;7390.667419966101;7411.7035318587195;7416.925830741678;7511.136219334791;7340.522866013692;7465.552066875977;7465.888011679829;7473.476856620012;7475.700971961115;7414.184439711627;7420.072490938633;7479.027726395589;7489.550626962372;7513.24867513247;7415.555066696015;7424.071991001125;7441.516301440389;7443.739469118555;7443.8883416748795;7342.265773422669;7366.300201480851;7394;7396.4822462427655;7400.333969942677;35012.12469688253;35016.82491587551;35100.64899351025;35109.12227194315;35112.64887351119;3329.783564068352;3364.730821534296;3384.7799893007123;3398.9660103398896;3412.931741365159;27813;27875.303117422023;27881.16356509308;27905.720942790515;28048;2959.9852000740075;2962.6296712910885;2995.086498617921;3008.3231272963626;3016.2308611304197;142058;142152;153824.46175538213;160481;160679;42858.785706071896;42914;42932.3560146598;43109.35335969963;43248.56751432445;45366.31950520745;45491.31763023557;45543.31685024661;45594.544054559694;51507.48492515102;14900.329485173193;15091.849081509265;15094;15125.924370378298;15225.619359515878;12358.134930554776;12450.875491245153;12461.75076498465;12465.376731163587;12505.562305319452;14315.427382904776;14390.856091439162;14412.207328596818;14422.84617230619;14430.206338651475;5670.801521946794;5774.855628609318;5809.128630705428;5920.4967577755515;5929.110633405024;984.8030393921244;989.7970915962211;1001.5242759689089;1007.652359935821;1013.533774463755;21643.891780541;22378.664320035212;22517.211897583835;22954.8852255741;23083.884580577327;1080.4597701149426;1083.7886612110563;1088.8693356797078;1097.4293367448881;1106.4191299567792;11913.463894124785;11982.58060967862;12129.21160124589;12292.323922184365;12793.552225672056;212417;214027;214887;214943;215074;46738.766306168254;46920.29619555709;47061;47165;47186.764066180134;1374.6288502104576;1418.4822539772908;1425.6649687323677;1431.041202394419;1462.3857979648574;21571.892140539825;22266.554668906854;22668.206612768474;22921.312360629207;23545.882270589223;33611.83194084014;43254.783726081165;43617.12765744731;43791.12417751691;44164.11671766611;188236;190818;192573;192745;192751;33328.1667958303;33515.16212094717;33636.32727345488;34254.82872585621;34445.48331775075;40345;41111.588884111974;41725.79137104295;41850.1629967405;42585.148297033265;29940.4011919756;30699;31013.534796977612;31374;31452;29450.852745736134;29936.203827770405;30272.84863575668;30939.381212375178;31640;33347.33305333831;34016.82991585026;34329.141771455914;34616.65383346134;34715.30569388648;28779.856100719364;29584.704152959057;30289.394212116076;30580;31315.68684313219;22147.889260553595;24274.878625606758;24553.75446245515;24592.50814983726;24670.876645616656 18:19:59 INFO - PID 12457 | |2;jquery.html;401.9220629346278;412.83486605357854;416.3754368447329;417.428123470845;422.275797008131;14456.204908730017;14987.175705336229;19859.801401985977;20522.48693782656;20548.07533660987;20947;21501.462463438424;21752.238671646457;21846.45383865404;21870.671939920874;5825.8834823303505;5948.910766338487;5985.820425387245;5989.43100405463;5993.520518358521;5877.5885688001645;5964.522838172936;5969.074793407029;6004.219451471325;6010.398960103977;5442.265294185274;5651.378348381675;5937.435943585352;5948.107783832416;5960.403959604027;5971.761129554812;6000.039993601046;6008.549358798085;6010.849728756794;6012.278526576839;5389.757460914229;5405.945940540583;5406.08096623571;5416.945830541684;5435.239066530688;24287.87856060726;24534.87732561326;24537.50924981508;24621.63067553988;24764.752352476604;1849.870509064366;1859.0890463672838;1864.8508119350556;1877.220953304377;1880.0881572437356;15989.520314390587;16677.749833752503;16748.58128546784;16762.32950681971;16772.83227167725;2212.966805497919;2234.084025549517;2265.444965983328;2266.7506574276817;2302.26327575176;118884.40557797156;121289;121384;121565;122135;11152.832707509393;11253.437328133561;11375.374354410422;11668.474918628512;11986.101042421853;16440.424585139463;16456.341746330254;16523.091229982227;16548.669026619402;16563.42028029013;8556.101609331055;8720.694775682821;8724.43291186071;8799.912000880036;8833.469991800512;8535.445196062235;8599.26906212979;8633;8704.434211776213;8718.520481373585;7372.115346158495;7456.105267367951;7489.737859174903;7518.173000969889;7551.660175292125;4281.2293787118615;4282.785253602989;4310.482742070909;4321.762303073361;4406.294992801137;964.6575465709712;968.7432830299977;973.1922504321396;996.7508122969258;1009.8182327181178;18241.452756417064;18559.072046397625;18968.430947071334;21821.345359639236;23242.1865234716;954.355809828363;982.1406269514175;990.2424645146468;1008.9142422893989;1014.4167103915278;10136;10330.380177189392;11752.294862308288;12913.741725165444;13274.93362533181;456889;457372;458277;459787;467069;107513;110453.44773276243;110992;110995;111731;1190.3215167354524;1193.373478923572;1225.4852961756262;1226.3929354969348;1230.4340003598265;18014.819851801316;19691.70462443093;20025.09887055057;20078.297259595845;20293.289734859798;49741.751291243316;50103;50130.24804628007;50346.7482662599;50598;63608.68195658992;63991.680041599495;64031.6798416005;64045.679771600844;64301.67849160724;10103.49482525856;10123.240756943405;10136.682231309882;10205.540750666089;10219.23355748307;17786.46640600784;18167.18247678884;18247;18370.173342199367;18572.349967751063;15426.074435533905;15476.303566339317;15492.147931863405;15493.380264789283;15582.298796554409;12093.334866582423;12157.756844862877;12551.623451296477;13382.197068175552;13714.86285137136;12556.87443125557;12779.23324600527;12783.721627837142;12798.104132710992;12808.6797830055;9890.703278901645;10014.699559013241;10060.44667543263;10139.695809125738;10241.334313269614;12787.61637150887;12891.41988610496;12918.418671159632;13098;13931.233782142079 18:19:59 INFO - PID 12457 | |3;mootools.html;1304.1197191895471;1362.8500864904865;1368.780995040793;1369.8287714035746;1375.0649558300354;10147.543360548774;10533.84199237012;10563.577456901725;10813;11142.49858756356;10960.28758130721;11128.38793866337;11144.944275278613;11170.664880053591;11171.776564468706;2325.2907863101746;2362.126013375054;2362.6692263083182;2363.149266264152;2366.1127077345996;2273.4998300373973;2314.6528020796845;2321.628539433691;2324.651302304651;2334.3347146063375;2262.4457008033055;2283.394900351408;2290.0496294037953;2292.403974966504;2294.5869743446174;2171.250918433138;2211.4471382154543;2221.44463884029;2233.3300009996938;2233.3300009997015;1909.8185672361242;1986.8112529309692;2189.5730332585154;2196.0666716645524;2208.9668654970187;10137.695869123865;10197.79604407915;10208.234382421348;10223.744406389826;10230.43732594707;5939.732712027969;6182.783602573888;6211.068339749028;6213.813585592439;6226.25284965807;3414.709749671281;3490.982545087258;3547.219611685425;3585.6593623605977;3597.1366871950804;1175.4592887271865;1184.4906690123244;1189.881011898812;1207.3842340406368;1215.2040413529064;15744.842551574453;15769.369225230977;15881.761773573406;15890.04659720409;15946.920265398714;4791.928121078186;4797.64017698674;4881.365422495053;4908.460069392364;4934;11730.178887477965;12037.819432708517;12068.155229133876;12078.27530348182;12094.57668981599;5921.111833225051;6009.849753756191;6031.9698401508585;6034.2155519782145;6061.484773794277;5541.667499950016;5596;5623.381428042912;5640.858978525488;5699.601027928088;4118.258713431611;4126.718848118367;4202.621764041251;4244.787760612019;4251.149770046003;1170.8068168752231;1171.3323405658693;1182.7811854806716;1193.5762804204555;1201.585453018707;823.2590668398369;823.3742355809508;826.3100311240182;828.1097819843692;858.819647873941;5915.280401256626;5935.317438494542;6042.4561789438285;6106.175666284995;6184.134221209034;557.631962904481;593.5904226083989;597.6742675242003;604.0214851939885;608.4189598933008;3823.789691566935;4062.614051665087;4195.328747400462;4356.150550642657;4386.868393948187;13586.38861251246;14098.013139080165;14098.365573549216;14107;14158.433662653584;13733.107348022346;13915.860841391659;13922.721545569235;13978.231197284247;14049.578512644433;7885.329746971457;8102.311303539147;8255.876161857577;8256.174382561696;8272.586370681322;6018.699065046642;6082.330943596113;6119.602225855305;6231.40801623845;6308.716107775253;12428.378581070729;12764.680882978;12812.487500499876;12983;13036.608901732963;12714;12718.745625087631;12771.80842287385;12895.613131606067;12938.417771200131;8981.506017169118;8984.55077246122;9008.369414140947;9120;9132.726018219464;10208.2343824212;10290.279680422298;10313.896861031293;10314.690559283234;10317.587296508056;8002.51984880909;8150.75547733569;8247.876281855897;8250.834983300421;8379.790505237173;8077.5961201940845;8247.793805154919;8326.875096873673;8342.708005219789;8449.873251901103;7408.148062972827;7426.220246874216;7463.141738700119;7470.103587569309;7476.5887876167335;5393.7033463159905;5815.5929084963645;5852.151438041546;5894.970525147347;6145.446909778141;5875.794347197828;5910.438508341701;5938.020226662725;5966.164736936746;6045.546584006129 18:19:59 INFO - PID 12457 | |4;prototype.html;389.36660708328566;391.8648066417085;392.5309255439749;395.1425406867098;401.49639599699134;6119.296280927695;6226.906596401058;6275.215598050244;6314.1475900753385;6388;6047.183630209931;6109.716959438523;6111.691257663348;6141.232345956755;6166.722497487613;4680.719156850583;4812.831550895719;4819.927701084478;4842.636802239828;4851.320815085891;4843.539863712942;4854.514548545152;4855.975720121394;4859;4865.927011094819;4763.5940302683575;4793;4797.40032495938;4802.5197480252045;4819.325294458778;4790.377250957354;4798;4816.80732770687;4823.734694591796;4830.227163653799;4199.790010499493;4208.747475151501;4209.494860616715;4214.115035842477;4229.6404805591565;6147.754089836446;6149.631022138641;6160.227897446167;6167.383261673842;6170.352113028112;5486.753096110645;5487.835364939018;5488.368837583689;5500.312460942382;5509.586780991442;6556.27880933097;6573.769918052893;6589.780890535267;6607.44086580258;6608.306127856554;4544.113897789933;4566.13243483737;4566.292224705176;4567.383403240553;4580.862574122782;6472.288048314682;6864.897026544606;6908.205556360982;6938.514303998722;6973.3375329344135;4548.7725613719185;4605.539446055434;4611.838585649486;4619.19164146273;4622.260438329851;4669.859904202879;4670.486246512881;4678.47949416441;4688.64835137366;4699.271612899937;5429.918551221735;5436.755346009439;5545.170093869094;5687.260656114679;5692.203091567184;6545.934540654628;6585.967070164715;6588.11060506835;6596.109525214035;6606.273309935903;1757.5939248601069;1779.644071185768;1782.3049010885766;1787.6067265201634;1787.7229029500447;1180.3861991764234;1230.2925817654705;1254.1471799176466;1261.9116661833766;1265.7152140768253;5778.855528611818;5884.499817515559;5907.32065812437;5911.157747464097;5930.436608522184;6746.561473504206;6760.560563563353;6775.62734049632;6786.321367863175;6792.286809884891;5813.941860581424;5825.300963884361;5845.824625261249;5878.735456904449;5881.1178323251;3582.7850328980344;3624.3294990426857;3631.927361452756;3645.8177091145335;3647.4164133738473;6583.934160658428;6587.736490540325;6588.308227636029;6590.419658337505;6598.637074960923;6906;6925.896111558331;6934.895976560356;6938.340857618619;6965.442764578822;6492.902606460907;6520.554791953017;6530.934690653033;6543.869122617616;6578.881590129689;5989.8203053908455;6754.898676519758;6786.185657720907;6795.490338224554;6814.795556133324;6717.529772915849;6727.798166055026;6742.629155396304;6744.865102698017;6754.425873800782;6400.51996100285;6592.835179120369;6594.241662208908;6601.603903765789;6621.801345959629;4585.335126406586;4595.218812801765;4615.3154098754385;4621.214393553037;4625.953740462553;6770.763023294161;6838.931610684029;6858.965705171442;6860.622665753432;6880.2431732508385;6559.8032059038305;6576.901346479711;6576.901346479711;6607.2071351438135;6609.669516524058;6562.5406221564035;6576.76981305652;6590.373914478117;6624;6624.370684784938;6401.167848179707;6440.194975628046;6442.420182183626;6444.742210311535;6504.447121994684;6651.900221496585;6675.532712710064;6688.498362622726;6688.933110668831;6694.966525167538;6356.2054743157105;6425.710843011982;6432.614043157426;6444;6450.322716114741 18:19:59 INFO - PID 12457 | |5;yui.html;823.2138307915941;855.2815634866707;855.3371137368539;859.5831021954355;874.3355050161877;14883.330250138742;15228;15406.537803865875;15692.293846776909;15793.921030394846;14974.775378369333;15156.469523566677;15728.528144155694;16677.332906683718;16914;918.2516249256851;936.6159874451442;936.7564433247371;939.9389039712431;941.5904081724437;955.507913424587;995.990040099597;995.9950200249025;1002.2483137646765;1002.4636819301675;1041.1046500009986;1052.6841947415783;1053.9051485366315;1054.3357684658654;1054.8206804843157;1048.182417714184;1048.6120135549857;1050.5482642463737;1051.5846240734904;1057.582255009271;764.4457768118125;765.3188662090744;766.8734658781294;767.9731209407644;770.3913908012663;15166.545003649799;16148;16215.189240538044;16228;16318.102504362256;17716;18202.726959095624;18250.361237356763;18254.634907301912;18381.172847221907;14134.717305653829;14646.194459304734;14758.778618320626;14783.334749936279;14826.110433374031;3427.4344733119005;3434.8969530914114;3446.276281980787;3460.6885380315894;3466.9479957800654;80687.59656201681;83398.16601833965;83783;84000.15999840046;84200.15799841985;14153;14726.63183420423;14978.47575334858;15097.849021509644;15177.544673659808;25526;25803.35491612687;26107.73892261091;26685.3328666781;26694.733052669613;7605.391568674493;7734.265244801735;7804.180561041123;7810.804729881798;7835.294823465915;3630.128769095451;3701.7038636908983;3712.8514859405323;3736.458213559073;3744.4196149596855;4047.817848196838;4219.641330486943;4225.704200705983;4231.597998190228;4235.97882010588;800.1558355934428;801.6472751989106;816.0941355095839;818.0510607695045;818.7298191596759;611.9571629985858;618.2673531864665;623.82844717703;632.3644737039247;643.4787821864305;10327.173826093895;10749.301295415773;10922.672319830417;11002.944985275182;11421.143414243965;648.303074195242;662.9194413106702;663.326723375774;671.5366397186024;681.7102731339161;4800.423949126127;4975.02996404309;5122.129238029544;5199.454057324002;5234.502722241381;82493;89859.55070224738;94464;95313;98543;69946.300536995;70682;71828.28171718217;75144.24855751482;75528.24471755321;63996;66828.33171668221;68672.65663671649;68806;71756.64121679463;11113.722156946142;11412.31526108436;11732.94133529327;11917.106172299229;12332.013438924685;27979.72020279771;28560.85719571389;29225.56161657534;29374.559381608866;29615.407691846474;53070.2039469416;54923;55005.72497137489;55684;56526;14635.634109147357;14809.555713328617;14883.255837208313;14994.550163495112;15056.548303550911;16062.839371606135;16580.336786528405;16829.915850420668;18112.818871811112;18455.354062608283;15701.450449234679;16023.519294421187;16477.01137931728;16548.503544893672;16705.164741763107;14777;15063.397464101752;15142.091474511564;15923;15970.121643309265;14406.42374305016;14931.850681493046;15657.373705052127;15891.682166356839;16149.354025838835;10116.241281904035;10428.478576071318;10557.52491137916;10762.838557421801;10806.189535785004;12912.418941147858;13167.209967401986;13391.464341426234;13766.174029558259;13781.379837907118 18:19:59 INFO - PID 12457 | __end_tp_report 18:19:59 INFO - PID 12457 | __start_cc_report 18:19:59 INFO - PID 12457 | _x_x_mozilla_cycle_collect,369 18:19:59 INFO - PID 12457 | __end_cc_report 18:19:59 INFO - PID 12457 | __startTimestamp1496798399063__endTimestamp 18:19:59 INFO - PID 12457 | 18:19:59 INFO - PID 12457 | ------- Summary: start ------- 18:19:59 INFO - PID 12457 | Number of tests: 6 18:19:59 INFO - PID 12457 | 18:19:59 INFO - PID 12457 | [#0] dojo.html Cycles:165 Average:5934.25 Median:6142.60 stddev:679.02 (11.1%) stddev-sans-first:643.01 18:19:59 INFO - PID 12457 | Values: 3075.7 3098.5 3103.6 3115.1 3125.3 5873.1 5965.0 5977.8 5981.2 6025.3 5940.4 5986.5 6016.0 6031.7 6052.8 5454.2 5528.6 5536.2 5576.7 5577.7 5624.2 5644.4 5677.9 5687.3 5692.3 5442.5 5454.8 5525.3 5555.3 5573.3 5522.1 5547.7 5547.7 5554.4 5594.2 5521.5 5528.4 5533.4 5534.9 5539.5 5825.3 5918.0 5971.2 6022.2 6024.4 6375.8 6381.6 6443.6 6474.8 6513.6 6549.6 6577.6 6588.8 6590.0 6593.2 5931.4 5978.6 6027.1 6029.1 6038.5 6489.3 6502.3 6564.9 6590.1 6590.8 6172.2 6178.6 6242.2 6321.9 6345.0 6356.3 6368.7 6401.1 6407.9 6409.9 6176.7 6413.4 6419.1 6422.6 6431.3 6292.5 6378.1 6427.5 6435.1 6462.3 5259.6 5265.0 5265.0 5275.2 5280.3 4482.3 4498.4 4499.9 4526.0 4527.0 5577.2 5638.7 5641.7 5686.9 5731.6 6498.4 6571.8 6575.3 6586.7 6602.2 5680.5 5685.5 5695.1 5720.9 5734.6 5422.6 5515.0 5602.9 5618.1 5621.9 6133.2 6185.8 6194.7 6199.0 6225.4 6430.6 6448.0 6494.8 6502.3 6515.0 6236.8 6255.4 6272.2 6299.7 6303.8 6142.0 6148.3 6195.6 6235.8 6240.0 6568.3 6576.1 6576.6 6581.5 6597.2 6070.0 6087.2 6142.6 6324.8 6325.8 6232.7 6274.9 6281.2 6287.8 6297.9 5976.1 6000.0 6038.7 6162.4 6165.5 6298.5 6310.5 6340.8 6365.8 6371.6 6173.7 6182.0 6187.8 6201.5 6209.8 18:19:59 INFO - PID 12457 | 18:19:59 INFO - PID 12457 | [#1] ext.html Cycles:180 Average:34729.49 Median:18328.98 stddev:48572.04 (265.0%) stddev-sans-first:48641.22 18:19:59 INFO - PID 12457 | Values: 734.9 777.4 799.8 1143.2 1149.6 35153.5 35698.0 35742.6 35759.8 35771.8 37221.4 37697.4 37770.2 37792.9 37797.0 7196.5 7390.7 7411.7 7416.9 7511.1 7340.5 7465.6 7465.9 7473.5 7475.7 7414.2 7420.1 7479.0 7489.6 7513.2 7415.6 7424.1 7441.5 7443.7 7443.9 7342.3 7366.3 7394.0 7396.5 7400.3 35012.1 35016.8 35100.6 35109.1 35112.6 3329.8 3364.7 3384.8 3399.0 3412.9 27813.0 27875.3 27881.2 27905.7 28048.0 2960.0 2962.6 2995.1 3008.3 3016.2 142058.0 142152.0 153824.5 160481.0 160679.0 42858.8 42914.0 42932.4 43109.4 43248.6 45366.3 45491.3 45543.3 45594.5 51507.5 14900.3 15091.8 15094.0 15125.9 15225.6 12358.1 12450.9 12461.8 12465.4 12505.6 14315.4 14390.9 14412.2 14422.8 14430.2 5670.8 5774.9 5809.1 5920.5 5929.1 984.8 989.8 1001.5 1007.7 1013.5 21643.9 22378.7 22517.2 22954.9 23083.9 1080.5 1083.8 1088.9 1097.4 1106.4 11913.5 11982.6 12129.2 12292.3 12793.6 212417.0 214027.0 214887.0 214943.0 215074.0 46738.8 46920.3 47061.0 47165.0 47186.8 1374.6 1418.5 1425.7 1431.0 1462.4 21571.9 22266.6 22668.2 22921.3 23545.9 33611.8 43254.8 43617.1 43791.1 44164.1 188236.0 190818.0 192573.0 192745.0 192751.0 33328.2 33515.2 33636.3 34254.8 34445.5 40345.0 41111.6 41725.8 41850.2 42585.1 29940.4 30699.0 31013.5 31374.0 31452.0 29450.9 29936.2 30272.8 30939.4 31640.0 33347.3 34016.8 34329.1 34616.7 34715.3 28779.9 29584.7 30289.4 30580.0 31315.7 22147.9 24274.9 24553.8 24592.5 24670.9 18:19:59 INFO - PID 12457 | 18:19:59 INFO - PID 12457 | [#2] jquery.html Cycles:180 Average:31230.73 Median:21224.23 stddev:77411.85 (364.7%) stddev-sans-first:77594.40 18:19:59 INFO - PID 12457 | Values: 401.9 412.8 416.4 417.4 422.3 14456.2 14987.2 19859.8 20522.5 20548.1 20947.0 21501.5 21752.2 21846.5 21870.7 5825.9 5948.9 5985.8 5989.4 5993.5 5877.6 5964.5 5969.1 6004.2 6010.4 5442.3 5651.4 5937.4 5948.1 5960.4 5971.8 6000.0 6008.5 6010.8 6012.3 5389.8 5405.9 5406.1 5416.9 5435.2 24287.9 24534.9 24537.5 24621.6 24764.8 1849.9 1859.1 1864.9 1877.2 1880.1 15989.5 16677.7 16748.6 16762.3 16772.8 2213.0 2234.1 2265.4 2266.8 2302.3 118884.4 121289.0 121384.0 121565.0 122135.0 11152.8 11253.4 11375.4 11668.5 11986.1 16440.4 16456.3 16523.1 16548.7 16563.4 8556.1 8720.7 8724.4 8799.9 8833.5 8535.4 8599.3 8633.0 8704.4 8718.5 7372.1 7456.1 7489.7 7518.2 7551.7 4281.2 4282.8 4310.5 4321.8 4406.3 964.7 968.7 973.2 996.8 1009.8 18241.5 18559.1 18968.4 21821.3 23242.2 954.4 982.1 990.2 1008.9 1014.4 10136.0 10330.4 11752.3 12913.7 13274.9 456889.0 457372.0 458277.0 459787.0 467069.0 107513.0 110453.4 110992.0 110995.0 111731.0 1190.3 1193.4 1225.5 1226.4 1230.4 18014.8 19691.7 20025.1 20078.3 20293.3 49741.8 50103.0 50130.2 50346.7 50598.0 63608.7 63991.7 64031.7 64045.7 64301.7 10103.5 10123.2 10136.7 10205.5 10219.2 17786.5 18167.2 18247.0 18370.2 18572.3 15426.1 15476.3 15492.1 15493.4 15582.3 12093.3 12157.8 12551.6 13382.2 13714.9 12556.9 12779.2 12783.7 12798.1 12808.7 9890.7 10014.7 10060.4 10139.7 10241.3 12787.6 12891.4 12918.4 13098.0 13931.2 18:19:59 INFO - PID 12457 | 18:19:59 INFO - PID 12457 | [#3] mootools.html Cycles:180 Average:6658.07 Median:3452.85 stddev:4279.26 (123.9%) stddev-sans-first:4272.35 18:19:59 INFO - PID 12457 | Values: 1304.1 1362.9 1368.8 1369.8 1375.1 10147.5 10533.8 10563.6 10813.0 11142.5 10960.3 11128.4 11144.9 11170.7 11171.8 2325.3 2362.1 2362.7 2363.1 2366.1 2273.5 2314.7 2321.6 2324.7 2334.3 2262.4 2283.4 2290.0 2292.4 2294.6 2171.3 2211.4 2221.4 2233.3 2233.3 1909.8 1986.8 2189.6 2196.1 2209.0 10137.7 10197.8 10208.2 10223.7 10230.4 5939.7 6182.8 6211.1 6213.8 6226.3 3414.7 3491.0 3547.2 3585.7 3597.1 1175.5 1184.5 1189.9 1207.4 1215.2 15744.8 15769.4 15881.8 15890.0 15946.9 4791.9 4797.6 4881.4 4908.5 4934.0 11730.2 12037.8 12068.2 12078.3 12094.6 5921.1 6009.8 6032.0 6034.2 6061.5 5541.7 5596.0 5623.4 5640.9 5699.6 4118.3 4126.7 4202.6 4244.8 4251.1 1170.8 1171.3 1182.8 1193.6 1201.6 823.3 823.4 826.3 828.1 858.8 5915.3 5935.3 6042.5 6106.2 6184.1 557.6 593.6 597.7 604.0 608.4 3823.8 4062.6 4195.3 4356.2 4386.9 13586.4 14098.0 14098.4 14107.0 14158.4 13733.1 13915.9 13922.7 13978.2 14049.6 7885.3 8102.3 8255.9 8256.2 8272.6 6018.7 6082.3 6119.6 6231.4 6308.7 12428.4 12764.7 12812.5 12983.0 13036.6 12714.0 12718.7 12771.8 12895.6 12938.4 8981.5 8984.6 9008.4 9120.0 9132.7 10208.2 10290.3 10313.9 10314.7 10317.6 8002.5 8150.8 8247.9 8250.8 8379.8 8077.6 8247.8 8326.9 8342.7 8449.9 7408.1 7426.2 7463.1 7470.1 7476.6 5393.7 5815.6 5852.2 5895.0 6145.4 5875.8 5910.4 5938.0 5966.2 6045.5 18:19:59 INFO - PID 12457 | 18:19:59 INFO - PID 12457 | [#4] prototype.html Cycles:180 Average:5461.86 Median:6144.49 stddev:1597.65 (26.0%) stddev-sans-first:1556.10 18:19:59 INFO - PID 12457 | Values: 389.4 391.9 392.5 395.1 401.5 6119.3 6226.9 6275.2 6314.1 6388.0 6047.2 6109.7 6111.7 6141.2 6166.7 4680.7 4812.8 4819.9 4842.6 4851.3 4843.5 4854.5 4856.0 4859.0 4865.9 4763.6 4793.0 4797.4 4802.5 4819.3 4790.4 4798.0 4816.8 4823.7 4830.2 4199.8 4208.7 4209.5 4214.1 4229.6 6147.8 6149.6 6160.2 6167.4 6170.4 5486.8 5487.8 5488.4 5500.3 5509.6 6556.3 6573.8 6589.8 6607.4 6608.3 4544.1 4566.1 4566.3 4567.4 4580.9 6472.3 6864.9 6908.2 6938.5 6973.3 4548.8 4605.5 4611.8 4619.2 4622.3 4669.9 4670.5 4678.5 4688.6 4699.3 5429.9 5436.8 5545.2 5687.3 5692.2 6545.9 6586.0 6588.1 6596.1 6606.3 1757.6 1779.6 1782.3 1787.6 1787.7 1180.4 1230.3 1254.1 1261.9 1265.7 5778.9 5884.5 5907.3 5911.2 5930.4 6746.6 6760.6 6775.6 6786.3 6792.3 5813.9 5825.3 5845.8 5878.7 5881.1 3582.8 3624.3 3631.9 3645.8 3647.4 6583.9 6587.7 6588.3 6590.4 6598.6 6906.0 6925.9 6934.9 6938.3 6965.4 6492.9 6520.6 6530.9 6543.9 6578.9 5989.8 6754.9 6786.2 6795.5 6814.8 6717.5 6727.8 6742.6 6744.9 6754.4 6400.5 6592.8 6594.2 6601.6 6621.8 4585.3 4595.2 4615.3 4621.2 4626.0 6770.8 6838.9 6859.0 6860.6 6880.2 6559.8 6576.9 6576.9 6607.2 6609.7 6562.5 6576.8 6590.4 6624.0 6624.4 6401.2 6440.2 6442.4 6444.7 6504.4 6651.9 6675.5 6688.5 6688.9 6695.0 6356.2 6425.7 6432.6 6444.0 6450.3 18:19:59 INFO - PID 12457 | 18:19:59 INFO - PID 12457 | [#5] yui.html Cycles:180 Average:18851.88 Median:26690.03 stddev:23970.18 (89.8%) stddev-sans-first:23999.19 18:19:59 INFO - PID 12457 | Values: 823.2 855.3 855.3 859.6 874.3 14883.3 15228.0 15406.5 15692.3 15793.9 14974.8 15156.5 15728.5 16677.3 16914.0 918.3 936.6 936.8 939.9 941.6 955.5 996.0 996.0 1002.2 1002.5 1041.1 1052.7 1053.9 1054.3 1054.8 1048.2 1048.6 1050.5 1051.6 1057.6 764.4 765.3 766.9 768.0 770.4 15166.5 16148.0 16215.2 16228.0 16318.1 17716.0 18202.7 18250.4 18254.6 18381.2 14134.7 14646.2 14758.8 14783.3 14826.1 3427.4 3434.9 3446.3 3460.7 3466.9 80687.6 83398.2 83783.0 84000.2 84200.2 14153.0 14726.6 14978.5 15097.8 15177.5 25526.0 25803.4 26107.7 26685.3 26694.7 7605.4 7734.3 7804.2 7810.8 7835.3 3630.1 3701.7 3712.9 3736.5 3744.4 4047.8 4219.6 4225.7 4231.6 4236.0 800.2 801.6 816.1 818.1 818.7 612.0 618.3 623.8 632.4 643.5 10327.2 10749.3 10922.7 11002.9 11421.1 648.3 662.9 663.3 671.5 681.7 4800.4 4975.0 5122.1 5199.5 5234.5 82493.0 89859.6 94464.0 95313.0 98543.0 69946.3 70682.0 71828.3 75144.2 75528.2 63996.0 66828.3 68672.7 68806.0 71756.6 11113.7 11412.3 11732.9 11917.1 12332.0 27979.7 28560.9 29225.6 29374.6 29615.4 53070.2 54923.0 55005.7 55684.0 56526.0 14635.6 14809.6 14883.3 14994.6 15056.5 16062.8 16580.3 16829.9 18112.8 18455.4 15701.5 16023.5 16477.0 16548.5 16705.2 14777.0 15063.4 15142.1 15923.0 15970.1 14406.4 14931.9 15657.4 15891.7 16149.4 10116.2 10428.5 10557.5 10762.8 10806.2 12912.4 13167.2 13391.5 13766.2 13781.4 18:19:59 INFO - PID 12457 | -------- Summary: end -------- 18:19:59 INFO - PID 12457 | 18:19:59 INFO - TEST-INFO | 12457: exit 0 18:19:59 INFO - TEST-OK | dromaeo_css | took 1142711ms 18:19:59 INFO - TEST-START | kraken 18:19:59 INFO - operating with platform_type : linux_ 18:19:59 INFO - Initialising browser for kraken test... 18:19:59 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56207/getInfo.html -profile /tmp/tmpHc7W7h/profile 18:19:59 INFO - TEST-INFO | started process 12884 (/builds/slave/test/build/application/firefox/firefox http://localhost:56207/getInfo.html) 18:20:34 INFO - TEST-INFO | 12884: killed by SIGTERM 18:20:35 INFO - Browser initialized. 18:20:35 INFO - Running cycle 1/1 for kraken test... 18:20:35 INFO - TEST-INFO | started process 13112 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHc7W7h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:20:46 INFO - PID 13112 | RSS: Main: 187899904 18:20:46 INFO - PID 13112 | 18:20:49 INFO - PID 13112 | Cycle 1(1): loaded http://localhost:56207/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56207/tests/kraken/driver.html?testName=audio-beat-detection) 18:20:50 INFO - PID 13112 | RSS: Main: 193527808 18:20:50 INFO - PID 13112 | 18:20:53 INFO - PID 13112 | Cycle 1(1): loaded http://localhost:56207/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56207/tests/kraken/driver.html?testName=audio-dft) 18:20:53 INFO - PID 13112 | RSS: Main: 191672320 18:20:53 INFO - PID 13112 | 18:20:56 INFO - PID 13112 | Cycle 1(1): loaded http://localhost:56207/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56207/tests/kraken/driver.html?testName=audio-fft) 18:20:57 INFO - PID 13112 | RSS: Main: 187994112 18:20:57 INFO - PID 13112 | 18:20:59 INFO - PID 13112 | Cycle 1(1): loaded http://localhost:56207/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56207/tests/kraken/driver.html?testName=audio-oscillator) 18:21:00 INFO - PID 13112 | RSS: Main: 188465152 18:21:00 INFO - PID 13112 | 18:21:02 INFO - PID 13112 | Cycle 1(1): loaded http://localhost:56207/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56207/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:21:02 INFO - PID 13112 | RSS: Main: 188563456 18:21:02 INFO - PID 13112 | 18:21:05 INFO - PID 13112 | Cycle 1(1): loaded http://localhost:56207/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56207/tests/kraken/driver.html?testName=imaging-darkroom) 18:21:06 INFO - PID 13112 | RSS: Main: 189878272 18:21:06 INFO - PID 13112 | 18:21:10 INFO - PID 13112 | Cycle 1(1): loaded http://localhost:56207/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56207/tests/kraken/driver.html?testName=imaging-desaturate) 18:21:10 INFO - PID 13112 | RSS: Main: 188784640 18:21:10 INFO - PID 13112 | 18:21:13 INFO - PID 13112 | Cycle 1(1): loaded http://localhost:56207/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56207/tests/kraken/driver.html?testName=json-parse-financial) 18:21:14 INFO - PID 13112 | RSS: Main: 189411328 18:21:14 INFO - PID 13112 | 18:21:15 INFO - PID 13112 | Cycle 1(1): loaded http://localhost:56207/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56207/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:21:16 INFO - PID 13112 | RSS: Main: 189341696 18:21:16 INFO - PID 13112 | 18:21:18 INFO - PID 13112 | Cycle 1(1): loaded http://localhost:56207/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56207/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:21:18 INFO - PID 13112 | RSS: Main: 189464576 18:21:18 INFO - PID 13112 | 18:21:20 INFO - PID 13112 | Cycle 1(1): loaded http://localhost:56207/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56207/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:21:21 INFO - PID 13112 | RSS: Main: 189767680 18:21:21 INFO - PID 13112 | 18:21:24 INFO - PID 13112 | Cycle 1(1): loaded http://localhost:56207/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56207/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:21:25 INFO - PID 13112 | RSS: Main: 189460480 18:21:25 INFO - PID 13112 | 18:21:28 INFO - PID 13112 | Cycle 1(1): loaded http://localhost:56207/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56207/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:21:28 INFO - PID 13112 | RSS: Main: 189415424 18:21:28 INFO - PID 13112 | 18:21:30 INFO - PID 13112 | Cycle 1(1): loaded http://localhost:56207/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56207/tests/kraken/driver.html?testName=ai-astar) 18:21:30 INFO - PID 13112 | RSS: Main: 191107072 18:21:30 INFO - PID 13112 | 18:21:30 INFO - PID 13112 | __start_tp_report 18:21:30 INFO - PID 13112 | _x_x_mozilla_page_load 18:21:30 INFO - PID 13112 | _x_x_mozilla_page_load_details 18:21:30 INFO - PID 13112 | |i|pagename|runs| 18:21:30 INFO - PID 13112 | |0;ai-astar;101;110;111;110;110;110;112;110;109;109 18:21:30 INFO - PID 13112 | |1;audio-beat-detection;157;126;121;168;132;121;120;123;143;122 18:21:30 INFO - PID 13112 | |2;audio-dft;167;165;165;162;165;166;167;175;164;165 18:21:30 INFO - PID 13112 | |3;audio-fft;73;73;73;110;74;76;74;74;97;73 18:21:30 INFO - PID 13112 | |4;audio-oscillator;82;83;103;83;83;82;98;82;82;108 18:21:30 INFO - PID 13112 | |5;imaging-gaussian-blur;114;116;113;114;115;114;114;115;114;115 18:21:30 INFO - PID 13112 | |6;imaging-darkroom;150;150;149;151;149;149;150;150;149;151 18:21:30 INFO - PID 13112 | |7;imaging-desaturate;94;95;94;95;97;94;94;94;95;95 18:21:30 INFO - PID 13112 | |8;json-parse-financial;53;53;53;53;57;52;54;56;53;58 18:21:30 INFO - PID 13112 | |9;json-stringify-tinderbox;56;56;56;58;55;56;57;59;56;56 18:21:30 INFO - PID 13112 | |10;stanford-crypto-aes;83;94;84;83;82;92;83;85;109;85 18:21:30 INFO - PID 13112 | |11;stanford-crypto-ccm;131;138;143;129;130;129;128;136;132;134 18:21:30 INFO - PID 13112 | |12;stanford-crypto-pbkdf2;187;188;189;195;188;187;186;187;191;199 18:21:30 INFO - PID 13112 | |13;stanford-crypto-sha256-iterative;72;70;77;70;71;75;78;71;70;73 18:21:30 INFO - PID 13112 | __end_tp_report 18:21:30 INFO - PID 13112 | __start_cc_report 18:21:30 INFO - PID 13112 | _x_x_mozilla_cycle_collect,1005 18:21:30 INFO - PID 13112 | __end_cc_report 18:21:30 INFO - PID 13112 | __startTimestamp1496798490796__endTimestamp 18:21:30 INFO - PID 13112 | 18:21:30 INFO - PID 13112 | ------- Summary: start ------- 18:21:30 INFO - PID 13112 | Number of tests: 14 18:21:30 INFO - PID 13112 | 18:21:30 INFO - PID 13112 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.00 stddev:3.01 (2.7%) stddev-sans-first:0.93 18:21:30 INFO - PID 13112 | Values: 101.0 110.0 111.0 110.0 110.0 110.0 112.0 110.0 109.0 109.0 18:21:30 INFO - PID 13112 | 18:21:30 INFO - PID 13112 | [#1] audio-beat-detection Cycles:10 Average:133.30 Median:129.00 stddev:17.09 (13.2%) stddev-sans-first:15.83 18:21:30 INFO - PID 13112 | Values: 157.0 126.0 121.0 168.0 132.0 121.0 120.0 123.0 143.0 122.0 18:21:30 INFO - PID 13112 | 18:21:30 INFO - PID 13112 | [#2] audio-dft Cycles:10 Average:166.10 Median:165.50 stddev:3.45 (2.1%) stddev-sans-first:3.64 18:21:30 INFO - PID 13112 | Values: 167.0 165.0 165.0 162.0 165.0 166.0 167.0 175.0 164.0 165.0 18:21:30 INFO - PID 13112 | 18:21:30 INFO - PID 13112 | [#3] audio-fft Cycles:10 Average:79.70 Median:74.00 stddev:12.94 (17.5%) stddev-sans-first:13.50 18:21:30 INFO - PID 13112 | Values: 73.0 73.0 73.0 110.0 74.0 76.0 74.0 74.0 97.0 73.0 18:21:30 INFO - PID 13112 | 18:21:30 INFO - PID 13112 | [#4] audio-oscillator Cycles:10 Average:88.60 Median:82.50 stddev:10.22 (12.4%) stddev-sans-first:10.56 18:21:30 INFO - PID 13112 | Values: 82.0 83.0 103.0 83.0 83.0 82.0 98.0 82.0 82.0 108.0 18:21:30 INFO - PID 13112 | 18:21:30 INFO - PID 13112 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.50 stddev:0.84 (0.7%) stddev-sans-first:0.88 18:21:30 INFO - PID 13112 | Values: 114.0 116.0 113.0 114.0 115.0 114.0 114.0 115.0 114.0 115.0 18:21:30 INFO - PID 13112 | 18:21:30 INFO - PID 13112 | [#6] imaging-darkroom Cycles:10 Average:149.80 Median:150.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 18:21:30 INFO - PID 13112 | Values: 150.0 150.0 149.0 151.0 149.0 149.0 150.0 150.0 149.0 151.0 18:21:30 INFO - PID 13112 | 18:21:30 INFO - PID 13112 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.95 (1.0%) stddev-sans-first:0.97 18:21:30 INFO - PID 13112 | Values: 94.0 95.0 94.0 95.0 97.0 94.0 94.0 94.0 95.0 95.0 18:21:30 INFO - PID 13112 | 18:21:30 INFO - PID 13112 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:53.50 stddev:2.04 (3.8%) stddev-sans-first:2.12 18:21:30 INFO - PID 13112 | Values: 53.0 53.0 53.0 53.0 57.0 52.0 54.0 56.0 53.0 58.0 18:21:30 INFO - PID 13112 | 18:21:30 INFO - PID 13112 | [#9] json-stringify-tinderbox Cycles:10 Average:56.50 Median:56.00 stddev:1.18 (2.1%) stddev-sans-first:1.24 18:21:30 INFO - PID 13112 | Values: 56.0 56.0 56.0 58.0 55.0 56.0 57.0 59.0 56.0 56.0 18:21:30 INFO - PID 13112 | 18:21:30 INFO - PID 13112 | [#10] stanford-crypto-aes Cycles:10 Average:88.00 Median:84.50 stddev:8.42 (10.0%) stddev-sans-first:8.73 18:21:30 INFO - PID 13112 | Values: 83.0 94.0 84.0 83.0 82.0 92.0 83.0 85.0 109.0 85.0 18:21:30 INFO - PID 13112 | 18:21:30 INFO - PID 13112 | [#11] stanford-crypto-ccm Cycles:10 Average:133.00 Median:133.00 stddev:4.78 (3.6%) stddev-sans-first:5.02 18:21:30 INFO - PID 13112 | Values: 131.0 138.0 143.0 129.0 130.0 129.0 128.0 136.0 132.0 134.0 18:21:30 INFO - PID 13112 | 18:21:30 INFO - PID 13112 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.70 Median:188.50 stddev:4.19 (2.2%) stddev-sans-first:4.33 18:21:30 INFO - PID 13112 | Values: 187.0 188.0 189.0 195.0 188.0 187.0 186.0 187.0 191.0 199.0 18:21:30 INFO - PID 13112 | 18:21:30 INFO - PID 13112 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.70 Median:72.50 stddev:2.98 (4.1%) stddev-sans-first:3.15 18:21:30 INFO - PID 13112 | Values: 72.0 70.0 77.0 70.0 71.0 75.0 78.0 71.0 70.0 73.0 18:21:30 INFO - PID 13112 | -------- Summary: end -------- 18:21:30 INFO - PID 13112 | 18:21:32 INFO - TEST-INFO | 13112: exit 0 18:21:32 INFO - TEST-OK | kraken | took 92098ms 18:21:32 INFO - SUITE-END | took 1234s 18:21:32 INFO - Completed test suite (00:20:35) 18:21:32 INFO - javascript benchmark 18:21:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7617.3685908885345, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3075.7231849133573, 3098.519729441937, 3103.6120484939383, 3115.1121930249883, 3125.3436778276573, 5873.148393482942, 5965.0, 5977.760889564418, 5981.162637230791, 6025.3070896846875, 5940.3762604926505, 5986.521078313735, 6016.0, 6031.72857221425, 6052.818415447544, 5454.236406903036, 5528.55771538277, 5536.197251398545, 5576.721163941807, 5577.749001294951, 5624.240727501796, 5644.3508996465525, 5677.886442271152, 5687.289088863892, 5692.288463942007, 5442.537384322337, 5454.754536045887, 5525.281713377275, 5555.333359996806, 5573.303337082885, 5522.144067669517, 5547.667139971614, 5547.72261386933, 5554.444555544414, 5594.160875868612, 5521.5306698930635, 5528.419515950807, 5533.363663178746, 5534.861628459281, 5539.501444869981, 5825.271841019872, 5917.970410147922, 5971.193888824996, 6022.187004754346, 6024.427679370453, 6375.808725738235, 6381.553291269613, 6443.613383197023, 6474.805755827333, 6513.576617519846, 6549.6070235786, 6577.638229897354, 6588.769393071268, 6589.967050164766, 6593.175853018372, 5931.436513531207, 5978.611390259619, 6027.126066720301, 6029.065494848305, 6038.486728628028, 6489.253735820346, 6502.284748677642, 6564.934350656527, 6590.077389165424, 6590.80227593173, 6172.22847144107, 6178.598391104564, 6242.219722534684, 6321.873562528724, 6345.0, 6356.269029061625, 6368.713407896656, 6401.071844582602, 6407.871842563122, 6409.935900641027, 6176.69116544171, 6413.390727880844, 6419.1334169887405, 6422.582532135396, 6431.2604050533855, 6292.4966002719675, 6378.075179099004, 6427.517936154807, 6435.131257280301, 6462.289148193695, 5259.605529585297, 5264.999650066475, 5264.999650066475, 5275.208718692227, 5280.287161233185, 4482.260427029569, 4498.415206023262, 4499.932501012488, 4526.0, 4527.0, 5577.191307260506, 5638.746256418471, 5641.717914104361, 5686.947914635805, 5731.598788084794, 6498.350164983558, 6571.835704107436, 6575.342465753386, 6586.670666466657, 6602.240742314695, 5680.5455563554815, 5685.545156387479, 5695.060315048054, 5720.885582288331, 5734.569907256889, 5422.566194704415, 5515.007298686275, 5602.915956260659, 5618.101103823368, 5621.915671264935, 6133.202683651186, 6185.783497577563, 6194.690265486798, 6199.039148931923, 6225.3774622537385, 6430.582012169194, 6447.967760161357, 6494.837629059311, 6502.284748677736, 6515.0, 6236.750529978932, 6255.437010669061, 6272.2159730033745, 6299.6535190564955, 6303.810885673437, 6141.969290153521, 6148.3236843948025, 6195.566310358232, 6235.844103897439, 6239.96880015597, 6568.277489476058, 6576.079348891255, 6576.638284894377, 6581.506387020897, 6597.241317248578, 6069.969650151721, 6087.178230938766, 6142.600730952474, 6324.810255692337, 6325.778597749057, 6232.657203853832, 6274.905876411766, 6281.246250449975, 6287.779927702509, 6297.937020629735, 5976.133460648269, 6000.039993601003, 6038.6678732670125, 6162.352952939877, 6165.506759459322, 6298.464630506458, 6310.463610593151, 6340.778072767431, 6365.777197798055, 6371.617702937839, 6173.722182501888, 6182.0, 6187.84530386744, 6201.472874805692, 6209.813705588839], "value": 5884.993175596733, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [734.9081364829397, 777.3586790897509, 799.8240387114836, 1143.2168964259488, 1149.5574203931494, 35153.47269790955, 35698.0, 35742.64257357429, 35759.82120089399, 35771.821140894324, 37221.441678374846, 37697.434538481946, 37770.24459510815, 37792.86621401362, 37797.0, 7196.460265480084, 7390.667419966101, 7411.7035318587195, 7416.925830741678, 7511.136219334791, 7340.522866013692, 7465.552066875977, 7465.888011679829, 7473.476856620012, 7475.700971961115, 7414.184439711627, 7420.072490938633, 7479.027726395589, 7489.550626962372, 7513.24867513247, 7415.555066696015, 7424.071991001125, 7441.516301440389, 7443.739469118555, 7443.8883416748795, 7342.265773422669, 7366.300201480851, 7394.0, 7396.4822462427655, 7400.333969942677, 35012.12469688253, 35016.82491587551, 35100.64899351025, 35109.12227194315, 35112.64887351119, 3329.783564068352, 3364.730821534296, 3384.7799893007123, 3398.9660103398896, 3412.931741365159, 27813.0, 27875.303117422023, 27881.16356509308, 27905.720942790515, 28048.0, 2959.9852000740075, 2962.6296712910885, 2995.086498617921, 3008.3231272963626, 3016.2308611304197, 142058.0, 142152.0, 153824.46175538213, 160481.0, 160679.0, 42858.785706071896, 42914.0, 42932.3560146598, 43109.35335969963, 43248.56751432445, 45366.31950520745, 45491.31763023557, 45543.31685024661, 45594.544054559694, 51507.48492515102, 14900.329485173193, 15091.849081509265, 15094.0, 15125.924370378298, 15225.619359515878, 12358.134930554776, 12450.875491245153, 12461.75076498465, 12465.376731163587, 12505.562305319452, 14315.427382904776, 14390.856091439162, 14412.207328596818, 14422.84617230619, 14430.206338651475, 5670.801521946794, 5774.855628609318, 5809.128630705428, 5920.4967577755515, 5929.110633405024, 984.8030393921244, 989.7970915962211, 1001.5242759689089, 1007.652359935821, 1013.533774463755, 21643.891780541, 22378.664320035212, 22517.211897583835, 22954.8852255741, 23083.884580577327, 1080.4597701149426, 1083.7886612110563, 1088.8693356797078, 1097.4293367448881, 1106.4191299567792, 11913.463894124785, 11982.58060967862, 12129.21160124589, 12292.323922184365, 12793.552225672056, 212417.0, 214027.0, 214887.0, 214943.0, 215074.0, 46738.766306168254, 46920.29619555709, 47061.0, 47165.0, 47186.764066180134, 1374.6288502104576, 1418.4822539772908, 1425.6649687323677, 1431.041202394419, 1462.3857979648574, 21571.892140539825, 22266.554668906854, 22668.206612768474, 22921.312360629207, 23545.882270589223, 33611.83194084014, 43254.783726081165, 43617.12765744731, 43791.12417751691, 44164.11671766611, 188236.0, 190818.0, 192573.0, 192745.0, 192751.0, 33328.1667958303, 33515.16212094717, 33636.32727345488, 34254.82872585621, 34445.48331775075, 40345.0, 41111.588884111974, 41725.79137104295, 41850.1629967405, 42585.148297033265, 29940.4011919756, 30699.0, 31013.534796977612, 31374.0, 31452.0, 29450.852745736134, 29936.203827770405, 30272.84863575668, 30939.381212375178, 31640.0, 33347.33305333831, 34016.82991585026, 34329.141771455914, 34616.65383346134, 34715.30569388648, 28779.856100719364, 29584.704152959057, 30289.394212116076, 30580.0, 31315.68684313219, 22147.889260553595, 24274.878625606758, 24553.75446245515, 24592.50814983726, 24670.876645616656], "value": 16183.337513382694, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.9220629346278, 412.83486605357854, 416.3754368447329, 417.428123470845, 422.275797008131, 14456.204908730017, 14987.175705336229, 19859.801401985977, 20522.48693782656, 20548.07533660987, 20947.0, 21501.462463438424, 21752.238671646457, 21846.45383865404, 21870.671939920874, 5825.8834823303505, 5948.910766338487, 5985.820425387245, 5989.43100405463, 5993.520518358521, 5877.5885688001645, 5964.522838172936, 5969.074793407029, 6004.219451471325, 6010.398960103977, 5442.265294185274, 5651.378348381675, 5937.435943585352, 5948.107783832416, 5960.403959604027, 5971.761129554812, 6000.039993601046, 6008.549358798085, 6010.849728756794, 6012.278526576839, 5389.757460914229, 5405.945940540583, 5406.08096623571, 5416.945830541684, 5435.239066530688, 24287.87856060726, 24534.87732561326, 24537.50924981508, 24621.63067553988, 24764.752352476604, 1849.870509064366, 1859.0890463672838, 1864.8508119350556, 1877.220953304377, 1880.0881572437356, 15989.520314390587, 16677.749833752503, 16748.58128546784, 16762.32950681971, 16772.83227167725, 2212.966805497919, 2234.084025549517, 2265.444965983328, 2266.7506574276817, 2302.26327575176, 118884.40557797156, 121289.0, 121384.0, 121565.0, 122135.0, 11152.832707509393, 11253.437328133561, 11375.374354410422, 11668.474918628512, 11986.101042421853, 16440.424585139463, 16456.341746330254, 16523.091229982227, 16548.669026619402, 16563.42028029013, 8556.101609331055, 8720.694775682821, 8724.43291186071, 8799.912000880036, 8833.469991800512, 8535.445196062235, 8599.26906212979, 8633.0, 8704.434211776213, 8718.520481373585, 7372.115346158495, 7456.105267367951, 7489.737859174903, 7518.173000969889, 7551.660175292125, 4281.2293787118615, 4282.785253602989, 4310.482742070909, 4321.762303073361, 4406.294992801137, 964.6575465709712, 968.7432830299977, 973.1922504321396, 996.7508122969258, 1009.8182327181178, 18241.452756417064, 18559.072046397625, 18968.430947071334, 21821.345359639236, 23242.1865234716, 954.355809828363, 982.1406269514175, 990.2424645146468, 1008.9142422893989, 1014.4167103915278, 10136.0, 10330.380177189392, 11752.294862308288, 12913.741725165444, 13274.93362533181, 456889.0, 457372.0, 458277.0, 459787.0, 467069.0, 107513.0, 110453.44773276243, 110992.0, 110995.0, 111731.0, 1190.3215167354524, 1193.373478923572, 1225.4852961756262, 1226.3929354969348, 1230.4340003598265, 18014.819851801316, 19691.70462443093, 20025.09887055057, 20078.297259595845, 20293.289734859798, 49741.751291243316, 50103.0, 50130.24804628007, 50346.7482662599, 50598.0, 63608.68195658992, 63991.680041599495, 64031.6798416005, 64045.679771600844, 64301.67849160724, 10103.49482525856, 10123.240756943405, 10136.682231309882, 10205.540750666089, 10219.23355748307, 17786.46640600784, 18167.18247678884, 18247.0, 18370.173342199367, 18572.349967751063, 15426.074435533905, 15476.303566339317, 15492.147931863405, 15493.380264789283, 15582.298796554409, 12093.334866582423, 12157.756844862877, 12551.623451296477, 13382.197068175552, 13714.86285137136, 12556.87443125557, 12779.23324600527, 12783.721627837142, 12798.104132710992, 12808.6797830055, 9890.703278901645, 10014.699559013241, 10060.44667543263, 10139.695809125738, 10241.334313269614, 12787.61637150887, 12891.41988610496, 12918.418671159632, 13098.0, 13931.233782142079], "value": 10495.430110208597, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1304.1197191895471, 1362.8500864904865, 1368.780995040793, 1369.8287714035746, 1375.0649558300354, 10147.543360548774, 10533.84199237012, 10563.577456901725, 10813.0, 11142.49858756356, 10960.28758130721, 11128.38793866337, 11144.944275278613, 11170.664880053591, 11171.776564468706, 2325.2907863101746, 2362.126013375054, 2362.6692263083182, 2363.149266264152, 2366.1127077345996, 2273.4998300373973, 2314.6528020796845, 2321.628539433691, 2324.651302304651, 2334.3347146063375, 2262.4457008033055, 2283.394900351408, 2290.0496294037953, 2292.403974966504, 2294.5869743446174, 2171.250918433138, 2211.4471382154543, 2221.44463884029, 2233.3300009996938, 2233.3300009997015, 1909.8185672361242, 1986.8112529309692, 2189.5730332585154, 2196.0666716645524, 2208.9668654970187, 10137.695869123865, 10197.79604407915, 10208.234382421348, 10223.744406389826, 10230.43732594707, 5939.732712027969, 6182.783602573888, 6211.068339749028, 6213.813585592439, 6226.25284965807, 3414.709749671281, 3490.982545087258, 3547.219611685425, 3585.6593623605977, 3597.1366871950804, 1175.4592887271865, 1184.4906690123244, 1189.881011898812, 1207.3842340406368, 1215.2040413529064, 15744.842551574453, 15769.369225230977, 15881.761773573406, 15890.04659720409, 15946.920265398714, 4791.928121078186, 4797.64017698674, 4881.365422495053, 4908.460069392364, 4934.0, 11730.178887477965, 12037.819432708517, 12068.155229133876, 12078.27530348182, 12094.57668981599, 5921.111833225051, 6009.849753756191, 6031.9698401508585, 6034.2155519782145, 6061.484773794277, 5541.667499950016, 5596.0, 5623.381428042912, 5640.858978525488, 5699.601027928088, 4118.258713431611, 4126.718848118367, 4202.621764041251, 4244.787760612019, 4251.149770046003, 1170.8068168752231, 1171.3323405658693, 1182.7811854806716, 1193.5762804204555, 1201.585453018707, 823.2590668398369, 823.3742355809508, 826.3100311240182, 828.1097819843692, 858.819647873941, 5915.280401256626, 5935.317438494542, 6042.4561789438285, 6106.175666284995, 6184.134221209034, 557.631962904481, 593.5904226083989, 597.6742675242003, 604.0214851939885, 608.4189598933008, 3823.789691566935, 4062.614051665087, 4195.328747400462, 4356.150550642657, 4386.868393948187, 13586.38861251246, 14098.013139080165, 14098.365573549216, 14107.0, 14158.433662653584, 13733.107348022346, 13915.860841391659, 13922.721545569235, 13978.231197284247, 14049.578512644433, 7885.329746971457, 8102.311303539147, 8255.876161857577, 8256.174382561696, 8272.586370681322, 6018.699065046642, 6082.330943596113, 6119.602225855305, 6231.40801623845, 6308.716107775253, 12428.378581070729, 12764.680882978, 12812.487500499876, 12983.0, 13036.608901732963, 12714.0, 12718.745625087631, 12771.80842287385, 12895.613131606067, 12938.417771200131, 8981.506017169118, 8984.55077246122, 9008.369414140947, 9120.0, 9132.726018219464, 10208.2343824212, 10290.279680422298, 10313.896861031293, 10314.690559283234, 10317.587296508056, 8002.51984880909, 8150.75547733569, 8247.876281855897, 8250.834983300421, 8379.790505237173, 8077.5961201940845, 8247.793805154919, 8326.875096873673, 8342.708005219789, 8449.873251901103, 7408.148062972827, 7426.220246874216, 7463.141738700119, 7470.103587569309, 7476.5887876167335, 5393.7033463159905, 5815.5929084963645, 5852.151438041546, 5894.970525147347, 6145.446909778141, 5875.794347197828, 5910.438508341701, 5938.020226662725, 5966.164736936746, 6045.546584006129], "value": 4977.692531418267, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.36660708328566, 391.8648066417085, 392.5309255439749, 395.1425406867098, 401.49639599699134, 6119.296280927695, 6226.906596401058, 6275.215598050244, 6314.1475900753385, 6388.0, 6047.183630209931, 6109.716959438523, 6111.691257663348, 6141.232345956755, 6166.722497487613, 4680.719156850583, 4812.831550895719, 4819.927701084478, 4842.636802239828, 4851.320815085891, 4843.539863712942, 4854.514548545152, 4855.975720121394, 4859.0, 4865.927011094819, 4763.5940302683575, 4793.0, 4797.40032495938, 4802.5197480252045, 4819.325294458778, 4790.377250957354, 4798.0, 4816.80732770687, 4823.734694591796, 4830.227163653799, 4199.790010499493, 4208.747475151501, 4209.494860616715, 4214.115035842477, 4229.6404805591565, 6147.754089836446, 6149.631022138641, 6160.227897446167, 6167.383261673842, 6170.352113028112, 5486.753096110645, 5487.835364939018, 5488.368837583689, 5500.312460942382, 5509.586780991442, 6556.27880933097, 6573.769918052893, 6589.780890535267, 6607.44086580258, 6608.306127856554, 4544.113897789933, 4566.13243483737, 4566.292224705176, 4567.383403240553, 4580.862574122782, 6472.288048314682, 6864.897026544606, 6908.205556360982, 6938.514303998722, 6973.3375329344135, 4548.7725613719185, 4605.539446055434, 4611.838585649486, 4619.19164146273, 4622.260438329851, 4669.859904202879, 4670.486246512881, 4678.47949416441, 4688.64835137366, 4699.271612899937, 5429.918551221735, 5436.755346009439, 5545.170093869094, 5687.260656114679, 5692.203091567184, 6545.934540654628, 6585.967070164715, 6588.11060506835, 6596.109525214035, 6606.273309935903, 1757.5939248601069, 1779.644071185768, 1782.3049010885766, 1787.6067265201634, 1787.7229029500447, 1180.3861991764234, 1230.2925817654705, 1254.1471799176466, 1261.9116661833766, 1265.7152140768253, 5778.855528611818, 5884.499817515559, 5907.32065812437, 5911.157747464097, 5930.436608522184, 6746.561473504206, 6760.560563563353, 6775.62734049632, 6786.321367863175, 6792.286809884891, 5813.941860581424, 5825.300963884361, 5845.824625261249, 5878.735456904449, 5881.1178323251, 3582.7850328980344, 3624.3294990426857, 3631.927361452756, 3645.8177091145335, 3647.4164133738473, 6583.934160658428, 6587.736490540325, 6588.308227636029, 6590.419658337505, 6598.637074960923, 6906.0, 6925.896111558331, 6934.895976560356, 6938.340857618619, 6965.442764578822, 6492.902606460907, 6520.554791953017, 6530.934690653033, 6543.869122617616, 6578.881590129689, 5989.8203053908455, 6754.898676519758, 6786.185657720907, 6795.490338224554, 6814.795556133324, 6717.529772915849, 6727.798166055026, 6742.629155396304, 6744.865102698017, 6754.425873800782, 6400.51996100285, 6592.835179120369, 6594.241662208908, 6601.603903765789, 6621.801345959629, 4585.335126406586, 4595.218812801765, 4615.3154098754385, 4621.214393553037, 4625.953740462553, 6770.763023294161, 6838.931610684029, 6858.965705171442, 6860.622665753432, 6880.2431732508385, 6559.8032059038305, 6576.901346479711, 6576.901346479711, 6607.2071351438135, 6609.669516524058, 6562.5406221564035, 6576.76981305652, 6590.373914478117, 6624.0, 6624.370684784938, 6401.167848179707, 6440.194975628046, 6442.420182183626, 6444.742210311535, 6504.447121994684, 6651.900221496585, 6675.532712710064, 6688.498362622726, 6688.933110668831, 6694.966525167538, 6356.2054743157105, 6425.710843011982, 6432.614043157426, 6444.0, 6450.322716114741], "value": 4968.57039571823, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [823.2138307915941, 855.2815634866707, 855.3371137368539, 859.5831021954355, 874.3355050161877, 14883.330250138742, 15228.0, 15406.537803865875, 15692.293846776909, 15793.921030394846, 14974.775378369333, 15156.469523566677, 15728.528144155694, 16677.332906683718, 16914.0, 918.2516249256851, 936.6159874451442, 936.7564433247371, 939.9389039712431, 941.5904081724437, 955.507913424587, 995.990040099597, 995.9950200249025, 1002.2483137646765, 1002.4636819301675, 1041.1046500009986, 1052.6841947415783, 1053.9051485366315, 1054.3357684658654, 1054.8206804843157, 1048.182417714184, 1048.6120135549857, 1050.5482642463737, 1051.5846240734904, 1057.582255009271, 764.4457768118125, 765.3188662090744, 766.8734658781294, 767.9731209407644, 770.3913908012663, 15166.545003649799, 16148.0, 16215.189240538044, 16228.0, 16318.102504362256, 17716.0, 18202.726959095624, 18250.361237356763, 18254.634907301912, 18381.172847221907, 14134.717305653829, 14646.194459304734, 14758.778618320626, 14783.334749936279, 14826.110433374031, 3427.4344733119005, 3434.8969530914114, 3446.276281980787, 3460.6885380315894, 3466.9479957800654, 80687.59656201681, 83398.16601833965, 83783.0, 84000.15999840046, 84200.15799841985, 14153.0, 14726.63183420423, 14978.47575334858, 15097.849021509644, 15177.544673659808, 25526.0, 25803.35491612687, 26107.73892261091, 26685.3328666781, 26694.733052669613, 7605.391568674493, 7734.265244801735, 7804.180561041123, 7810.804729881798, 7835.294823465915, 3630.128769095451, 3701.7038636908983, 3712.8514859405323, 3736.458213559073, 3744.4196149596855, 4047.817848196838, 4219.641330486943, 4225.704200705983, 4231.597998190228, 4235.97882010588, 800.1558355934428, 801.6472751989106, 816.0941355095839, 818.0510607695045, 818.7298191596759, 611.9571629985858, 618.2673531864665, 623.82844717703, 632.3644737039247, 643.4787821864305, 10327.173826093895, 10749.301295415773, 10922.672319830417, 11002.944985275182, 11421.143414243965, 648.303074195242, 662.9194413106702, 663.326723375774, 671.5366397186024, 681.7102731339161, 4800.423949126127, 4975.02996404309, 5122.129238029544, 5199.454057324002, 5234.502722241381, 82493.0, 89859.55070224738, 94464.0, 95313.0, 98543.0, 69946.300536995, 70682.0, 71828.28171718217, 75144.24855751482, 75528.24471755321, 63996.0, 66828.33171668221, 68672.65663671649, 68806.0, 71756.64121679463, 11113.722156946142, 11412.31526108436, 11732.94133529327, 11917.106172299229, 12332.013438924685, 27979.72020279771, 28560.85719571389, 29225.56161657534, 29374.559381608866, 29615.407691846474, 53070.2039469416, 54923.0, 55005.72497137489, 55684.0, 56526.0, 14635.634109147357, 14809.555713328617, 14883.255837208313, 14994.550163495112, 15056.548303550911, 16062.839371606135, 16580.336786528405, 16829.915850420668, 18112.818871811112, 18455.354062608283, 15701.450449234679, 16023.519294421187, 16477.01137931728, 16548.503544893672, 16705.164741763107, 14777.0, 15063.397464101752, 15142.091474511564, 15923.0, 15970.121643309265, 14406.42374305016, 14931.850681493046, 15657.373705052127, 15891.682166356839, 16149.354025838835, 10116.241281904035, 10428.478576071318, 10557.52491137916, 10762.838557421801, 10806.189535785004, 12912.418941147858, 13167.209967401986, 13391.464341426234, 13766.174029558259, 13781.379837907118], "value": 7901.808023807783, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1529.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 111.0, 110.0, 110.0, 110.0, 112.0, 110.0, 109.0, 109.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 126.0, 121.0, 168.0, 132.0, 121.0, 120.0, 123.0, 143.0, 122.0], "value": 133.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 165.0, 165.0, 162.0, 165.0, 166.0, 167.0, 175.0, 164.0, 165.0], "value": 166.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 110.0, 74.0, 76.0, 74.0, 74.0, 97.0, 73.0], "value": 79.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 103.0, 83.0, 83.0, 82.0, 98.0, 82.0, 82.0, 108.0], "value": 88.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 113.0, 114.0, 115.0, 114.0, 114.0, 115.0, 114.0, 115.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 149.0, 151.0, 149.0, 149.0, 150.0, 150.0, 149.0, 151.0], "value": 149.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 97.0, 94.0, 94.0, 94.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 53.0, 57.0, 52.0, 54.0, 56.0, 53.0, 58.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 58.0, 55.0, 56.0, 57.0, 59.0, 56.0, 56.0], "value": 56.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 94.0, 84.0, 83.0, 82.0, 92.0, 83.0, 85.0, 109.0, 85.0], "value": 88.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 138.0, 143.0, 129.0, 130.0, 129.0, 128.0, 136.0, 132.0, 134.0], "value": 133.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 188.0, 189.0, 195.0, 188.0, 187.0, 186.0, 187.0, 191.0, 199.0], "value": 189.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 70.0, 77.0, 70.0, 71.0, 75.0, 78.0, 71.0, 70.0, 73.0], "value": 72.7, "unit": "score"}]}]} 18:21:32 INFO - Return code: 0 18:21:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:21:32 INFO - # TBPL SUCCESS # 18:21:32 INFO - Running post-action listener: _resource_record_post_action 18:21:32 INFO - [mozharness: 2017-06-07 01:21:32.664481Z] Finished run-tests step (success) 18:21:32 INFO - Running post-run listener: _resource_record_post_run 18:21:32 INFO - Total resource usage - Wall time: 1253s; CPU: 13.0%; Read bytes: 159744; Write bytes: 433618944; Read time: 356; Write time: 247904 18:21:32 INFO - TinderboxPrint: CPU usage
12.6% 18:21:32 INFO - TinderboxPrint: I/O read bytes / time
159,744 / 356 18:21:32 INFO - TinderboxPrint: I/O write bytes / time
433,618,944 / 247,904 18:21:32 INFO - TinderboxPrint: CPU idle
8,734.4 (87.3%) 18:21:32 INFO - TinderboxPrint: CPU user
1,211.4 (12.1%) 18:21:32 INFO - TinderboxPrint: Swap in / out
0 / 0 18:21:32 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 103903232; Read time: 36; Write time: 81068 18:21:32 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:21:32 INFO - run-tests - Wall time: 1236s; CPU: 13.0%; Read bytes: 155648; Write bytes: 329715712; Read time: 320; Write time: 166836 18:21:33 INFO - Running post-run listener: _upload_blobber_files 18:21:33 INFO - Blob upload gear active. 18:21:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:21:33 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 18:21:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:21:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:21:33 INFO - (blobuploader) - INFO - Open directory for files ... 18:21:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:21:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:21:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:21:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:21:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:21:34 INFO - (blobuploader) - INFO - Done attempting. 18:21:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:21:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:21:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:21:35 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:21:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:21:35 INFO - (blobuploader) - INFO - Done attempting. 18:21:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:21:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:21:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:21:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:21:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:21:36 INFO - (blobuploader) - INFO - Done attempting. 18:21:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:21:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:21:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:21:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:21:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:21:42 INFO - (blobuploader) - INFO - Done attempting. 18:21:42 INFO - (blobuploader) - INFO - Iteration through files over. 18:21:42 INFO - Return code: 0 18:21:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:21:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:21:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92e09875968587022935f77a00bbe205865e70a41ef7bacc8ab47f7d918a39a5e1ecb5fdac3e7b664647915840a201e7e5e3b6ed87489a8c707a0f3b223135b4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e490ae15dd599444eb438770debcb103cd84bde2d2b60c67cb4ed8d1127abc5c7381a298ea5210f2f150908f2f64d2f60f680bef8372d22aa409607e166005e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1220d178795c9692f48dc63c9795b1122a1df9080009f40bf38d168d75caa1ff8359df5e0ca4f66b3730ee8a504bd3aa144559088534683211c4b20333eaa29", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f669d429799640d4f445b636aac393708fa2f54eb78da0e332bd9a0e3b862006db1955891c4ea5a7e21157e09ee595b811b5b94b84595cac61a8379db83e180"} 18:21:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:21:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:21:42 INFO - Contents: 18:21:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92e09875968587022935f77a00bbe205865e70a41ef7bacc8ab47f7d918a39a5e1ecb5fdac3e7b664647915840a201e7e5e3b6ed87489a8c707a0f3b223135b4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e490ae15dd599444eb438770debcb103cd84bde2d2b60c67cb4ed8d1127abc5c7381a298ea5210f2f150908f2f64d2f60f680bef8372d22aa409607e166005e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1220d178795c9692f48dc63c9795b1122a1df9080009f40bf38d168d75caa1ff8359df5e0ca4f66b3730ee8a504bd3aa144559088534683211c4b20333eaa29", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f669d429799640d4f445b636aac393708fa2f54eb78da0e332bd9a0e3b862006db1955891c4ea5a7e21157e09ee595b811b5b94b84595cac61a8379db83e180"} 18:21:42 INFO - Running post-run listener: copy_logs_to_upload_dir 18:21:42 INFO - Copying logs to upload dir... 18:21:42 INFO - mkdir: /builds/slave/test/build/upload/logs 18:21:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1312.711328 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 52 secs) (at 2017-06-06 18:21:42.696596) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-06 18:21:42.704046) ========= 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=652eb03db935cfc1c15ebda0000001ad-1496789342.373627-1721748896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92e09875968587022935f77a00bbe205865e70a41ef7bacc8ab47f7d918a39a5e1ecb5fdac3e7b664647915840a201e7e5e3b6ed87489a8c707a0f3b223135b4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e490ae15dd599444eb438770debcb103cd84bde2d2b60c67cb4ed8d1127abc5c7381a298ea5210f2f150908f2f64d2f60f680bef8372d22aa409607e166005e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1220d178795c9692f48dc63c9795b1122a1df9080009f40bf38d168d75caa1ff8359df5e0ca4f66b3730ee8a504bd3aa144559088534683211c4b20333eaa29", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f669d429799640d4f445b636aac393708fa2f54eb78da0e332bd9a0e3b862006db1955891c4ea5a7e21157e09ee595b811b5b94b84595cac61a8379db83e180"} build_url:https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011481 build_url: 'https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92e09875968587022935f77a00bbe205865e70a41ef7bacc8ab47f7d918a39a5e1ecb5fdac3e7b664647915840a201e7e5e3b6ed87489a8c707a0f3b223135b4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e490ae15dd599444eb438770debcb103cd84bde2d2b60c67cb4ed8d1127abc5c7381a298ea5210f2f150908f2f64d2f60f680bef8372d22aa409607e166005e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1220d178795c9692f48dc63c9795b1122a1df9080009f40bf38d168d75caa1ff8359df5e0ca4f66b3730ee8a504bd3aa144559088534683211c4b20333eaa29", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f669d429799640d4f445b636aac393708fa2f54eb78da0e332bd9a0e3b862006db1955891c4ea5a7e21157e09ee595b811b5b94b84595cac61a8379db83e180"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-06 18:21:42.731564) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-06 18:21:42.731939) ========= 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=652eb03db935cfc1c15ebda0000001ad-1496789342.373627-1721748896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004448 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-06 18:21:42.813750) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-06 18:21:42.814097) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-06 18:21:42.814426) ========= ========= Total master_lag: 0.23 =========