builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-004 starttime: 1495727527.21 results: success (0) revision: f7adbf457ee20eeffde72694e0d17d73616e3cfd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-25 08:52:07.205649) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-25 08:52:07.206096) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-25 08:52:07.206369) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-25 08:52:07.249016) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 08:52:07.249361) ========= 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=c6927cf182745ad25b1d38b9000001fe-1495720935.175755-1451179319 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-25 08:52:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 23.5M=0s 2017-05-25 08:52:07 (23.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.286156 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 08:52:07.553091) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 08:52:07.553399) ========= 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=c6927cf182745ad25b1d38b9000001fe-1495720935.175755-1451179319 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018285 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 08:52:07.606189) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-25 08:52:07.606554) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f7adbf457ee20eeffde72694e0d17d73616e3cfd --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 f7adbf457ee20eeffde72694e0d17d73616e3cfd --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=c6927cf182745ad25b1d38b9000001fe-1495720935.175755-1451179319 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-25 08:52:07,674 truncating revision to first 12 chars 2017-05-25 08:52:07,674 Setting DEBUG logging. 2017-05-25 08:52:07,674 attempt 1/10 2017-05-25 08:52:07,674 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f7adbf457ee2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-25 08:52:08,515 unpacking tar archive at: mozilla-central-f7adbf457ee2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.177549 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-25 08:52:08.799424) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-25 08:52:08.799749) ========= script_repo_revision: f7adbf457ee20eeffde72694e0d17d73616e3cfd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-25 08:52:08.800150) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-25 08:52:08.800409) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-25 08:52:08.808792) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 58 secs) (at 2017-05-25 08:52:08.809113) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1495720935.175755-1451179319 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:52:09 INFO - MultiFileLogger online at 20170525 08:52:09 in /builds/slave/test 08:52:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:52:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:52:09 INFO - {'append_to_log': False, 08:52:09 INFO - 'base_work_dir': '/builds/slave/test', 08:52:09 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:52:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:52:09 INFO - 'branch': 'Firefox-Non-PGO', 08:52:09 INFO - 'buildbot_json_path': 'buildprops.json', 08:52:09 INFO - 'config_files': ('talos/linux_config.py',), 08:52:09 INFO - 'default_actions': ('clobber', 08:52:09 INFO - 'read-buildbot-config', 08:52:09 INFO - 'download-and-extract', 08:52:09 INFO - 'populate-webroot', 08:52:09 INFO - 'create-virtualenv', 08:52:09 INFO - 'install', 08:52:09 INFO - 'run-tests'), 08:52:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:52:09 INFO - 'download_minidump_stackwalk': True, 08:52:09 INFO - 'download_symbols': 'ondemand', 08:52:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:52:09 INFO - 'tooltool.py': '/tools/tooltool.py', 08:52:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:52:09 INFO - '/tools/misc-python/virtualenv.py')}, 08:52:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:52:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:52:09 INFO - 'gecko_profile': False, 08:52:09 INFO - 'gecko_profile_interval': 0, 08:52:09 INFO - 'installer_path': 'installer.exe', 08:52:09 INFO - 'log_level': 'info', 08:52:09 INFO - 'log_name': 'talos', 08:52:09 INFO - 'log_to_console': True, 08:52:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:52:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:52:09 INFO - 'opt_config_files': (), 08:52:09 INFO - 'pip_index': False, 08:52:09 INFO - 'suite': 'dromaeojs-e10s', 08:52:09 INFO - 'system_bits': '32', 08:52:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:52:09 INFO - 'title': 'talos-linux64-ix-004', 08:52:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:52:09 INFO - 'use_talos_json': True, 08:52:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:52:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:52:09 INFO - 'work_dir': 'build'} 08:52:09 INFO - [mozharness: 2017-05-25 15:52:09.088700Z] Running clobber step. 08:52:09 INFO - Running pre-action listener: _resource_record_pre_action 08:52:09 INFO - Running main action method: clobber 08:52:09 INFO - rmtree: /builds/slave/test/build 08:52:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:52:10 INFO - Running post-action listener: _resource_record_post_action 08:52:10 INFO - [mozharness: 2017-05-25 15:52:10.079097Z] Finished clobber step (success) 08:52:10 INFO - [mozharness: 2017-05-25 15:52:10.079198Z] Running read-buildbot-config step. 08:52:10 INFO - Running pre-action listener: _resource_record_pre_action 08:52:10 INFO - Running main action method: read_buildbot_config 08:52:10 INFO - Using buildbot properties: 08:52:10 INFO - { 08:52:10 INFO - "project": "", 08:52:10 INFO - "product": "firefox", 08:52:10 INFO - "who": "ffxbld@noreply.mozilla.org", 08:52:10 INFO - "installer_path": "public/build/target.tar.bz2", 08:52:10 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:52:10 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:52:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 08:52:10 INFO - "stage_platform": "linux64", 08:52:10 INFO - "basedir": "/builds/slave/test", 08:52:10 INFO - "buildnumber": 633, 08:52:10 INFO - "platform": "ubuntu64_hw", 08:52:10 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:52:10 INFO - "slavebuilddir": "test", 08:52:10 INFO - "taskId": "OdAvRvs_Q8emSdNrMZyAJQ", 08:52:10 INFO - "branch": "mozilla-central", 08:52:10 INFO - "script_repo_revision": "production", 08:52:10 INFO - "revision": "f7adbf457ee20eeffde72694e0d17d73616e3cfd", 08:52:10 INFO - "slavename": "talos-linux64-ix-004", 08:52:10 INFO - "repo_path": "mozilla-central" 08:52:10 INFO - } 08:52:10 INFO - Finding installer, test and symbols from parent task. 08:52:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OdAvRvs_Q8emSdNrMZyAJQ'}, attempt #1 08:52:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OdAvRvs_Q8emSdNrMZyAJQ'}, attempt #1 08:52:10 INFO - Task dependencies: Qr857TJ7Qg2wIq7dexMhkw 08:52:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qr857TJ7Qg2wIq7dexMhkw'}, attempt #1 08:52:11 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Qr857TJ7Qg2wIq7dexMhkw/artifacts/public/build/target.tar.bz2 08:52:11 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Qr857TJ7Qg2wIq7dexMhkw/artifacts/public/build/test_packages.json 08:52:11 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Qr857TJ7Qg2wIq7dexMhkw/artifacts/public/build/target.crashreporter-symbols.zip 08:52:11 INFO - Running post-action listener: _resource_record_post_action 08:52:11 INFO - [mozharness: 2017-05-25 15:52:11.458050Z] Finished read-buildbot-config step (success) 08:52:11 INFO - [mozharness: 2017-05-25 15:52:11.458272Z] Running download-and-extract step. 08:52:11 INFO - Running pre-action listener: _resource_record_pre_action 08:52:11 INFO - Running main action method: download_and_extract 08:52:11 INFO - mkdir: /builds/slave/test/build/tests 08:52:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:11 INFO - trying https://queue.taskcluster.net/v1/task/Qr857TJ7Qg2wIq7dexMhkw/artifacts/public/build/target.test_packages.json 08:52:11 INFO - Downloading https://queue.taskcluster.net/v1/task/Qr857TJ7Qg2wIq7dexMhkw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:52:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qr857TJ7Qg2wIq7dexMhkw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:52:12 INFO - Downloaded 986 bytes. 08:52:12 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:52:12 INFO - Using the following test package requirements: 08:52:12 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:52:12 INFO - u'common': [u'target.common.tests.zip'], 08:52:12 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:52:12 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:52:12 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:52:12 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:52:12 INFO - u'mozbase': [u'target.common.tests.zip'], 08:52:12 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:52:12 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:52:12 INFO - u'web-platform': [u'target.common.tests.zip', 08:52:12 INFO - u'target.web-platform.tests.zip'], 08:52:12 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:52:12 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:52:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qr857TJ7Qg2wIq7dexMhkw/artifacts/public/build/target.common.tests.zip 08:52:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qr857TJ7Qg2wIq7dexMhkw/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:52:12 INFO - Fetch https://queue.taskcluster.net/v1/task/Qr857TJ7Qg2wIq7dexMhkw/artifacts/public/build/target.common.tests.zip into memory 08:52:13 INFO - Content-Length response header: 63531928 08:52:13 INFO - Bytes received: 63531928 08:52:24 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:52:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qr857TJ7Qg2wIq7dexMhkw/artifacts/public/build/target.common.tests.zip 08:52:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qr857TJ7Qg2wIq7dexMhkw/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:52:24 INFO - Fetch https://queue.taskcluster.net/v1/task/Qr857TJ7Qg2wIq7dexMhkw/artifacts/public/build/target.common.tests.zip into memory 08:52:25 INFO - Content-Length response header: 63531928 08:52:25 INFO - Bytes received: 63531928 08:52:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qr857TJ7Qg2wIq7dexMhkw/artifacts/public/build/target.talos.tests.zip 08:52:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qr857TJ7Qg2wIq7dexMhkw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:52:38 INFO - Fetch https://queue.taskcluster.net/v1/task/Qr857TJ7Qg2wIq7dexMhkw/artifacts/public/build/target.talos.tests.zip into memory 08:52:39 INFO - Content-Length response header: 14411859 08:52:39 INFO - Bytes received: 14411859 08:52:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:39 INFO - trying https://queue.taskcluster.net/v1/task/Qr857TJ7Qg2wIq7dexMhkw/artifacts/public/build/target.tar.bz2 08:52:39 INFO - Downloading https://queue.taskcluster.net/v1/task/Qr857TJ7Qg2wIq7dexMhkw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:52:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qr857TJ7Qg2wIq7dexMhkw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:52:41 INFO - Downloaded 54135751 bytes. 08:52:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Qr857TJ7Qg2wIq7dexMhkw/artifacts/public/build/target.tar.bz2 08:52:41 INFO - mkdir: /builds/slave/test/properties 08:52:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:52:41 INFO - Writing to file /builds/slave/test/properties/build_url 08:52:41 INFO - Contents: 08:52:41 INFO - build_url:https://queue.taskcluster.net/v1/task/Qr857TJ7Qg2wIq7dexMhkw/artifacts/public/build/target.tar.bz2 08:52:41 INFO - Running post-action listener: _resource_record_post_action 08:52:41 INFO - Running post-action listener: set_extra_try_arguments 08:52:41 INFO - [mozharness: 2017-05-25 15:52:41.061089Z] Finished download-and-extract step (success) 08:52:41 INFO - [mozharness: 2017-05-25 15:52:41.061315Z] Running populate-webroot step. 08:52:41 INFO - Running pre-action listener: _resource_record_pre_action 08:52:41 INFO - Running main action method: populate_webroot 08:52:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:52:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:52:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:52:41 INFO - '--tppagecycles', 08:52:41 INFO - '7'], 08:52:41 INFO - 'tests': ['tsvgm']}}, 08:52:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:52:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:52:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:52:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:52:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:52:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:52:41 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:52:41 INFO - 'talos_options': ['--disable-e10s'], 08:52:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:52:41 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:52:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:52:41 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:52:41 INFO - 'talos_options': ['--disable-e10s'], 08:52:41 INFO - 'tests': ['damp', 'tps']}, 08:52:41 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:52:41 INFO - 'tests': ['damp', 'tps']}, 08:52:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:52:41 INFO - 'tests': ['dromaeo_dom']}, 08:52:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:52:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:52:41 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 08:52:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:52:41 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:52:41 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:52:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:52:41 INFO - 'tests': ['a11yr', 08:52:41 INFO - 'ts_paint', 08:52:41 INFO - 'tpaint', 08:52:41 INFO - 'sessionrestore', 08:52:41 INFO - 'sessionrestore_no_auto_restore', 08:52:41 INFO - 'tabpaint']}, 08:52:41 INFO - 'other-e10s': {'tests': ['a11yr', 08:52:41 INFO - 'ts_paint', 08:52:41 INFO - 'tpaint', 08:52:41 INFO - 'sessionrestore', 08:52:41 INFO - 'sessionrestore_no_auto_restore', 08:52:41 INFO - 'tabpaint']}, 08:52:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:52:41 INFO - 'ts_paint', 08:52:41 INFO - 'tpaint', 08:52:41 INFO - 'sessionrestore', 08:52:41 INFO - 'sessionrestore_no_auto_restore', 08:52:41 INFO - 'tabpaint']}, 08:52:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:52:41 INFO - 'ts_paint', 08:52:41 INFO - 'tpaint', 08:52:41 INFO - 'sessionrestore', 08:52:41 INFO - 'sessionrestore_no_auto_restore', 08:52:41 INFO - 'tabpaint']}, 08:52:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:52:41 INFO - 'tests': ['a11yr', 08:52:41 INFO - 'ts_paint', 08:52:41 INFO - 'tpaint', 08:52:41 INFO - 'sessionrestore', 08:52:41 INFO - 'sessionrestore_no_auto_restore', 08:52:41 INFO - 'tabpaint']}, 08:52:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:52:41 INFO - 'tests': ['a11yr', 08:52:41 INFO - 'ts_paint', 08:52:41 INFO - 'tpaint', 08:52:41 INFO - 'sessionrestore', 08:52:41 INFO - 'sessionrestore_no_auto_restore', 08:52:41 INFO - 'tabpaint']}, 08:52:41 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 08:52:41 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 08:52:41 INFO - 'bloom_basic_ref']}, 08:52:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:52:41 INFO - 'tests': ['tsvgx', 08:52:41 INFO - 'tsvgr_opacity', 08:52:41 INFO - 'tart', 08:52:41 INFO - 'tscrollx', 08:52:41 INFO - 'cart', 08:52:41 INFO - 'tsvg_static']}, 08:52:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:52:41 INFO - 'tsvgr_opacity', 08:52:41 INFO - 'tart', 08:52:41 INFO - 'tscrollx', 08:52:41 INFO - 'cart', 08:52:41 INFO - 'tsvg_static']}, 08:52:41 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:52:41 INFO - 'talos_options': ['--disable-e10s'], 08:52:41 INFO - 'tests': ['tp5o']}, 08:52:41 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:52:41 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:52:41 INFO - 'talos_options': ['--disable-e10s', 08:52:41 INFO - '--xperf_path', 08:52:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:52:41 INFO - 'tests': ['tp5n']}, 08:52:41 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:52:41 INFO - 'talos_options': ['--xperf_path', 08:52:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:52:41 INFO - 'tests': ['tp5n']}}, 08:52:41 INFO - 'talos.zip': {'path': '', 08:52:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:52:41 INFO - Running post-action listener: _resource_record_post_action 08:52:41 INFO - [mozharness: 2017-05-25 15:52:41.075445Z] Finished populate-webroot step (success) 08:52:41 INFO - [mozharness: 2017-05-25 15:52:41.075534Z] Running create-virtualenv step. 08:52:41 INFO - Running pre-action listener: _resource_record_pre_action 08:52:41 INFO - Running main action method: create_virtualenv 08:52:41 INFO - Creating virtualenv /builds/slave/test/build/venv 08:52:41 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 08:52:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:52:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:52:41 INFO - Using real prefix '/usr' 08:52:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:52:41 INFO - Installing distribute.............................................................................................................................................................................................done. 08:52:43 INFO - Installing pip.................done. 08:52:43 INFO - Return code: 0 08:52:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:52:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:52:44 INFO - Reading from file tmpfile_stdout 08:52:44 INFO - Output received: 08:52:44 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) 08:52:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:44 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 0x175b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1928a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ace5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acb7a0>, '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 0x1acc6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1accb30>, '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': 'c6927cf182745ad25b1d38b9000001fe-1495720935.175755-1451179319', '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 08:52:44 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 08:52:44 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 08:52:44 INFO - Using env: {'DISPLAY': ':0', 08:52:44 INFO - 'HOME': '/home/cltbld', 08:52:44 INFO - 'LANG': 'en_US.UTF-8', 08:52:44 INFO - 'LANGUAGE': 'en_US:en', 08:52:44 INFO - 'LOGNAME': 'cltbld', 08:52:44 INFO - 'MAIL': '/var/mail/cltbld', 08:52:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:44 INFO - 'MOZ_NO_REMOTE': '1', 08:52:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:44 INFO - 'NO_EM_RESTART': '1', 08:52:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:44 INFO - 'PWD': '/builds/slave/test', 08:52:44 INFO - 'SHELL': '/bin/bash', 08:52:44 INFO - 'SHLVL': '1', 08:52:44 INFO - 'TERM': 'linux', 08:52:44 INFO - 'TMOUT': '86400', 08:52:44 INFO - 'USER': 'cltbld', 08:52:44 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1495720935.175755-1451179319', 08:52:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:44 INFO - '_': '/tools/buildbot/bin/python'} 08:52:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:44 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 08:52:44 INFO - Cleaning up... 08:52:44 INFO - Return code: 0 08:52:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:44 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 0x175b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1928a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ace5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acb7a0>, '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 0x1acc6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1accb30>, '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': 'c6927cf182745ad25b1d38b9000001fe-1495720935.175755-1451179319', '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 08:52:44 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 08:52:44 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 08:52:44 INFO - Using env: {'DISPLAY': ':0', 08:52:44 INFO - 'HOME': '/home/cltbld', 08:52:44 INFO - 'LANG': 'en_US.UTF-8', 08:52:44 INFO - 'LANGUAGE': 'en_US:en', 08:52:44 INFO - 'LOGNAME': 'cltbld', 08:52:44 INFO - 'MAIL': '/var/mail/cltbld', 08:52:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:44 INFO - 'MOZ_NO_REMOTE': '1', 08:52:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:44 INFO - 'NO_EM_RESTART': '1', 08:52:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:44 INFO - 'PWD': '/builds/slave/test', 08:52:44 INFO - 'SHELL': '/bin/bash', 08:52:44 INFO - 'SHLVL': '1', 08:52:44 INFO - 'TERM': 'linux', 08:52:44 INFO - 'TMOUT': '86400', 08:52:44 INFO - 'USER': 'cltbld', 08:52:44 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1495720935.175755-1451179319', 08:52:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:44 INFO - '_': '/tools/buildbot/bin/python'} 08:52:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:44 INFO - Downloading/unpacking psutil>=3.1.1 08:52:44 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 08:52:44 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 08:52:44 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 08:52:44 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 08:52:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:52:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:52:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:52:45 INFO - Installing collected packages: psutil 08:52:45 INFO - Running setup.py install for psutil 08:52:45 INFO - building 'psutil._psutil_linux' extension 08:52:45 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 08:52:47 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 08:52:47 INFO - building 'psutil._psutil_posix' extension 08:52:47 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 08:52:47 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 08:52:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:52:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:52:47 INFO - Successfully installed psutil 08:52:47 INFO - Cleaning up... 08:52:47 INFO - Return code: 0 08:52:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:52:47 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')]} 08:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:47 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')]} 08:52:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:47 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 0x175b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1928a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ace5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acb7a0>, '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 0x1acc6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1accb30>, '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': 'c6927cf182745ad25b1d38b9000001fe-1495720935.175755-1451179319', '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 08:52:47 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 08:52:47 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 08:52:47 INFO - Using env: {'DISPLAY': ':0', 08:52:47 INFO - 'HOME': '/home/cltbld', 08:52:47 INFO - 'LANG': 'en_US.UTF-8', 08:52:47 INFO - 'LANGUAGE': 'en_US:en', 08:52:47 INFO - 'LOGNAME': 'cltbld', 08:52:47 INFO - 'MAIL': '/var/mail/cltbld', 08:52:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:47 INFO - 'MOZ_NO_REMOTE': '1', 08:52:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:47 INFO - 'NO_EM_RESTART': '1', 08:52:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:47 INFO - 'PWD': '/builds/slave/test', 08:52:47 INFO - 'SHELL': '/bin/bash', 08:52:47 INFO - 'SHLVL': '1', 08:52:47 INFO - 'TERM': 'linux', 08:52:47 INFO - 'TMOUT': '86400', 08:52:47 INFO - 'USER': 'cltbld', 08:52:47 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1495720935.175755-1451179319', 08:52:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:47 INFO - '_': '/tools/buildbot/bin/python'} 08:52:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:52:47 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 08:52:47 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 08:52:47 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 08:52:47 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 08:52:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:52:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:52:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:52:48 INFO - Installing collected packages: mozsystemmonitor 08:52:48 INFO - Running setup.py install for mozsystemmonitor 08:52:48 INFO - Successfully installed mozsystemmonitor 08:52:48 INFO - Cleaning up... 08:52:48 INFO - Return code: 0 08:52:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:52:48 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')]} 08:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:48 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')]} 08:52:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:48 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 0x175b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1928a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ace5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acb7a0>, '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 0x1acc6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1accb30>, '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': 'c6927cf182745ad25b1d38b9000001fe-1495720935.175755-1451179319', '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 08:52:48 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 08:52:48 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 08:52:48 INFO - Using env: {'DISPLAY': ':0', 08:52:48 INFO - 'HOME': '/home/cltbld', 08:52:48 INFO - 'LANG': 'en_US.UTF-8', 08:52:48 INFO - 'LANGUAGE': 'en_US:en', 08:52:48 INFO - 'LOGNAME': 'cltbld', 08:52:48 INFO - 'MAIL': '/var/mail/cltbld', 08:52:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:48 INFO - 'MOZ_NO_REMOTE': '1', 08:52:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:48 INFO - 'NO_EM_RESTART': '1', 08:52:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:48 INFO - 'PWD': '/builds/slave/test', 08:52:48 INFO - 'SHELL': '/bin/bash', 08:52:48 INFO - 'SHLVL': '1', 08:52:48 INFO - 'TERM': 'linux', 08:52:48 INFO - 'TMOUT': '86400', 08:52:48 INFO - 'USER': 'cltbld', 08:52:48 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1495720935.175755-1451179319', 08:52:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:48 INFO - '_': '/tools/buildbot/bin/python'} 08:52:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:49 INFO - Downloading/unpacking jsonschema==2.5.1 08:52:49 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 08:52:49 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 08:52:49 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 08:52:49 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 08:52:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:52:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:52:50 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 08:52:50 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 08:52:50 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 08:52:50 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 08:52:50 INFO - Downloading functools32-3.2.3-2.tar.gz 08:52:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:52:50 INFO - warning: no files found matching '*.txt' 08:52:50 INFO - no previously-included directories found matching 'build' 08:52:50 INFO - no previously-included directories found matching 'dist' 08:52:50 INFO - no previously-included directories found matching '.git*' 08:52:50 INFO - Installing collected packages: jsonschema, functools32 08:52:50 INFO - Running setup.py install for functools32 08:52:50 INFO - warning: no files found matching '*.txt' 08:52:50 INFO - no previously-included directories found matching 'build' 08:52:50 INFO - no previously-included directories found matching 'dist' 08:52:50 INFO - no previously-included directories found matching '.git*' 08:52:50 INFO - Successfully installed jsonschema functools32 08:52:50 INFO - Cleaning up... 08:52:50 INFO - Return code: 0 08:52:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:52:50 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')]} 08:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:50 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')]} 08:52:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:50 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 0x175b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1928a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ace5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acb7a0>, '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 0x1acc6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1accb30>, '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': 'c6927cf182745ad25b1d38b9000001fe-1495720935.175755-1451179319', '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 08:52:50 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 08:52:50 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 08:52:50 INFO - Using env: {'DISPLAY': ':0', 08:52:50 INFO - 'HOME': '/home/cltbld', 08:52:50 INFO - 'LANG': 'en_US.UTF-8', 08:52:50 INFO - 'LANGUAGE': 'en_US:en', 08:52:50 INFO - 'LOGNAME': 'cltbld', 08:52:50 INFO - 'MAIL': '/var/mail/cltbld', 08:52:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:50 INFO - 'MOZ_NO_REMOTE': '1', 08:52:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:50 INFO - 'NO_EM_RESTART': '1', 08:52:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:50 INFO - 'PWD': '/builds/slave/test', 08:52:50 INFO - 'SHELL': '/bin/bash', 08:52:50 INFO - 'SHLVL': '1', 08:52:50 INFO - 'TERM': 'linux', 08:52:50 INFO - 'TMOUT': '86400', 08:52:50 INFO - 'USER': 'cltbld', 08:52:50 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1495720935.175755-1451179319', 08:52:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:50 INFO - '_': '/tools/buildbot/bin/python'} 08:52:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:52:50 INFO - Cleaning up... 08:52:50 INFO - Return code: 0 08:52:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:52:50 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')]} 08:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:50 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')]} 08:52:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:50 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 0x175b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1928a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ace5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acb7a0>, '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 0x1acc6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1accb30>, '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': 'c6927cf182745ad25b1d38b9000001fe-1495720935.175755-1451179319', '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 08:52:50 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 08:52:50 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 08:52:50 INFO - Using env: {'DISPLAY': ':0', 08:52:50 INFO - 'HOME': '/home/cltbld', 08:52:50 INFO - 'LANG': 'en_US.UTF-8', 08:52:50 INFO - 'LANGUAGE': 'en_US:en', 08:52:50 INFO - 'LOGNAME': 'cltbld', 08:52:50 INFO - 'MAIL': '/var/mail/cltbld', 08:52:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:50 INFO - 'MOZ_NO_REMOTE': '1', 08:52:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:50 INFO - 'NO_EM_RESTART': '1', 08:52:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:50 INFO - 'PWD': '/builds/slave/test', 08:52:50 INFO - 'SHELL': '/bin/bash', 08:52:50 INFO - 'SHLVL': '1', 08:52:50 INFO - 'TERM': 'linux', 08:52:50 INFO - 'TMOUT': '86400', 08:52:50 INFO - 'USER': 'cltbld', 08:52:50 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1495720935.175755-1451179319', 08:52:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:50 INFO - '_': '/tools/buildbot/bin/python'} 08:52:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:51 INFO - Downloading/unpacking blobuploader==1.2.4 08:52:51 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 08:52:51 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 08:52:51 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 08:52:51 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 08:52:52 INFO - Downloading blobuploader-1.2.4.tar.gz 08:52:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:52:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:52:52 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 08:52:52 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 08:52:52 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 08:52:52 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 08:52:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:52:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:52:52 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 08:52:52 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 08:52:52 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 08:52:52 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 08:52:52 INFO - Downloading docopt-0.6.1.tar.gz 08:52:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:52:52 INFO - Installing collected packages: blobuploader, requests, docopt 08:52:52 INFO - Running setup.py install for blobuploader 08:52:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:52:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:52:52 INFO - Running setup.py install for requests 08:52:53 INFO - Running setup.py install for docopt 08:52:53 INFO - Successfully installed blobuploader requests docopt 08:52:53 INFO - Cleaning up... 08:52:53 INFO - Return code: 0 08:52:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:53 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 0x175b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1928a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ace5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acb7a0>, '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 0x1acc6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1accb30>, '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': 'c6927cf182745ad25b1d38b9000001fe-1495720935.175755-1451179319', '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 08:52:53 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 08:52:53 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 08:52:53 INFO - Using env: {'DISPLAY': ':0', 08:52:53 INFO - 'HOME': '/home/cltbld', 08:52:53 INFO - 'LANG': 'en_US.UTF-8', 08:52:53 INFO - 'LANGUAGE': 'en_US:en', 08:52:53 INFO - 'LOGNAME': 'cltbld', 08:52:53 INFO - 'MAIL': '/var/mail/cltbld', 08:52:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:53 INFO - 'MOZ_NO_REMOTE': '1', 08:52:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:53 INFO - 'NO_EM_RESTART': '1', 08:52:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:53 INFO - 'PWD': '/builds/slave/test', 08:52:53 INFO - 'SHELL': '/bin/bash', 08:52:53 INFO - 'SHLVL': '1', 08:52:53 INFO - 'TERM': 'linux', 08:52:53 INFO - 'TMOUT': '86400', 08:52:53 INFO - 'USER': 'cltbld', 08:52:53 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1495720935.175755-1451179319', 08:52:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:53 INFO - '_': '/tools/buildbot/bin/python'} 08:52:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:52:53 INFO - Running setup.py (path:/tmp/pip-wh1mEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:52:53 INFO - Running setup.py (path:/tmp/pip-e3iT7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:52:53 INFO - Running setup.py (path:/tmp/pip-OUpbTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:52:53 INFO - Running setup.py (path:/tmp/pip-yXhKNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:52:53 INFO - Running setup.py (path:/tmp/pip-SYufhx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:52:53 INFO - Running setup.py (path:/tmp/pip-MyWOZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:52:53 INFO - Running setup.py (path:/tmp/pip-JDTxZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:52:54 INFO - Running setup.py (path:/tmp/pip-m8lteH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:52:54 INFO - Running setup.py (path:/tmp/pip-ayp6Kl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:52:54 INFO - Running setup.py (path:/tmp/pip-TniL6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:52:54 INFO - Running setup.py (path:/tmp/pip-33imhy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:52:54 INFO - Running setup.py (path:/tmp/pip-zazJaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:52:54 INFO - Running setup.py (path:/tmp/pip-agCsAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:52:54 INFO - Running setup.py (path:/tmp/pip-4oUyO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:52:54 INFO - Running setup.py (path:/tmp/pip-8yN0yr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:52:54 INFO - Running setup.py (path:/tmp/pip-3QSQbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:52:54 INFO - Running setup.py (path:/tmp/pip-xDpKLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:52:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:52:54 INFO - Running setup.py install for manifestparser 08:52:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:52:54 INFO - Running setup.py install for mozcrash 08:52:54 INFO - Running setup.py install for mozdebug 08:52:55 INFO - Running setup.py install for mozdevice 08:52:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:52:55 INFO - Running setup.py install for mozfile 08:52:55 INFO - Running setup.py install for mozhttpd 08:52:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:52:55 INFO - Running setup.py install for mozinfo 08:52:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:52:55 INFO - Running setup.py install for mozInstall 08:52:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:52:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:52:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:52:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:52:55 INFO - Running setup.py install for mozleak 08:52:55 INFO - Running setup.py install for mozlog 08:52:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:52:55 INFO - Running setup.py install for moznetwork 08:52:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:52:55 INFO - Running setup.py install for mozprocess 08:52:56 INFO - Running setup.py install for mozprofile 08:52:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:52:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:52:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:52:56 INFO - Running setup.py install for mozrunner 08:52:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:52:56 INFO - Running setup.py install for mozscreenshot 08:52:56 INFO - Running setup.py install for moztest 08:52:56 INFO - Running setup.py install for mozversion 08:52:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:52:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:52:56 INFO - Cleaning up... 08:52:56 INFO - Return code: 0 08:52:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:52: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')]} 08:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52: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')]} 08:52:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:56 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 0x175b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1928a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ace5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acb7a0>, '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 0x1acc6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1accb30>, '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': 'c6927cf182745ad25b1d38b9000001fe-1495720935.175755-1451179319', '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 08:52:56 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 08:52:56 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 08:52:56 INFO - Using env: {'DISPLAY': ':0', 08:52:56 INFO - 'HOME': '/home/cltbld', 08:52:56 INFO - 'LANG': 'en_US.UTF-8', 08:52:56 INFO - 'LANGUAGE': 'en_US:en', 08:52:56 INFO - 'LOGNAME': 'cltbld', 08:52:56 INFO - 'MAIL': '/var/mail/cltbld', 08:52:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:56 INFO - 'MOZ_NO_REMOTE': '1', 08:52:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:56 INFO - 'NO_EM_RESTART': '1', 08:52:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:56 INFO - 'PWD': '/builds/slave/test', 08:52:56 INFO - 'SHELL': '/bin/bash', 08:52:56 INFO - 'SHLVL': '1', 08:52:56 INFO - 'TERM': 'linux', 08:52:56 INFO - 'TMOUT': '86400', 08:52:56 INFO - 'USER': 'cltbld', 08:52:56 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1495720935.175755-1451179319', 08:52:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:56 INFO - '_': '/tools/buildbot/bin/python'} 08:52:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:52:56 INFO - Running setup.py (path:/tmp/pip-fGNT1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:52:56 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)) 08:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:52:56 INFO - Running setup.py (path:/tmp/pip-RZpHRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:52:56 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)) 08:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:52:56 INFO - Running setup.py (path:/tmp/pip-I4DMSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:52:57 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)) 08:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:52:57 INFO - Running setup.py (path:/tmp/pip-5JGPCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:52:57 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)) 08:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:52:57 INFO - Running setup.py (path:/tmp/pip-uDlvpR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:52:57 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)) 08:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:52:57 INFO - Running setup.py (path:/tmp/pip-C6x2gn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:52:57 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)) 08:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:52:57 INFO - Running setup.py (path:/tmp/pip-yPdBjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:52:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:52:57 INFO - Running setup.py (path:/tmp/pip-yjtRdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:52:57 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)) 08:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:52:57 INFO - Running setup.py (path:/tmp/pip-kaOoNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:52:57 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)) 08:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:52:57 INFO - Running setup.py (path:/tmp/pip-vmqaW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:52:57 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)) 08:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:52:57 INFO - Running setup.py (path:/tmp/pip-zZTHfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:52:57 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)) 08:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:52:57 INFO - Running setup.py (path:/tmp/pip-akuJTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:52:57 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)) 08:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:52:57 INFO - Running setup.py (path:/tmp/pip-p7dCRq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:52:57 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)) 08:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:52:57 INFO - Running setup.py (path:/tmp/pip-iEg4eW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:52:57 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)) 08:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:52:57 INFO - Running setup.py (path:/tmp/pip-7GPfeA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:52:57 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)) 08:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:52:57 INFO - Running setup.py (path:/tmp/pip-oNQ_ep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:52:57 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)) 08:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:52:57 INFO - Running setup.py (path:/tmp/pip-3bJ1vs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:52:58 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)) 08:52:58 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)) 08:52:58 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)) 08:52:58 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)) 08:52:58 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)) 08:52:58 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)) 08:52:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:52:58 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 08:52:58 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 08:52:58 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 08:52:58 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 08:52:59 INFO - Downloading blessings-1.6.tar.gz 08:52:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:52:59 INFO - Installing collected packages: blessings 08:52:59 INFO - Running setup.py install for blessings 08:52:59 INFO - Successfully installed blessings 08:52:59 INFO - Cleaning up... 08:52:59 INFO - Return code: 0 08:52:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:52:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:52:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:52:59 INFO - Reading from file tmpfile_stdout 08:52:59 INFO - Current package versions: 08:52:59 INFO - argparse == 1.2.1 08:52:59 INFO - blessings == 1.6 08:52:59 INFO - blobuploader == 1.2.4 08:52:59 INFO - docopt == 0.6.1 08:52:59 INFO - functools32 == 3.2.3-2 08:52:59 INFO - jsonschema == 2.5.1 08:52:59 INFO - manifestparser == 1.1 08:52:59 INFO - mozInstall == 1.12 08:52:59 INFO - mozcrash == 1.0 08:52:59 INFO - mozdebug == 0.1 08:52:59 INFO - mozdevice == 0.51 08:52:59 INFO - mozfile == 1.2 08:52:59 INFO - mozhttpd == 0.7 08:52:59 INFO - mozinfo == 0.9 08:52:59 INFO - mozleak == 0.1 08:52:59 INFO - mozlog == 3.4 08:52:59 INFO - moznetwork == 0.27 08:52:59 INFO - mozprocess == 0.25 08:52:59 INFO - mozprofile == 0.28 08:52:59 INFO - mozrunner == 6.13 08:52:59 INFO - mozscreenshot == 0.1 08:52:59 INFO - mozsystemmonitor == 0.3 08:52:59 INFO - moztest == 0.8 08:52:59 INFO - mozversion == 1.4 08:52:59 INFO - psutil == 3.1.1 08:52:59 INFO - requests == 1.2.3 08:52:59 INFO - wsgiref == 0.1.2 08:52:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:52:59 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')]} 08:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:59 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')]} 08:52:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:59 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 0x175b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1928a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ace5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acb7a0>, '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 0x1acc6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1accb30>, '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': 'c6927cf182745ad25b1d38b9000001fe-1495720935.175755-1451179319', '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 08:52:59 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 08:52:59 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 08:52:59 INFO - Using env: {'DISPLAY': ':0', 08:52:59 INFO - 'HOME': '/home/cltbld', 08:52:59 INFO - 'LANG': 'en_US.UTF-8', 08:52:59 INFO - 'LANGUAGE': 'en_US:en', 08:52:59 INFO - 'LOGNAME': 'cltbld', 08:52:59 INFO - 'MAIL': '/var/mail/cltbld', 08:52:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:59 INFO - 'MOZ_NO_REMOTE': '1', 08:52:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:59 INFO - 'NO_EM_RESTART': '1', 08:52:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:59 INFO - 'PWD': '/builds/slave/test', 08:52:59 INFO - 'SHELL': '/bin/bash', 08:52:59 INFO - 'SHLVL': '1', 08:52:59 INFO - 'TERM': 'linux', 08:52:59 INFO - 'TMOUT': '86400', 08:52:59 INFO - 'USER': 'cltbld', 08:52:59 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1495720935.175755-1451179319', 08:52:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:59 INFO - '_': '/tools/buildbot/bin/python'} 08:52:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:59 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)) 08:52:59 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)) 08:52:59 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)) 08:52:59 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)) 08:52:59 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)) 08:52:59 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)) 08:52:59 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)) 08:52:59 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)) 08:52:59 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)) 08:52:59 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:00 INFO - Downloading marionette_driver-1.4.0.tar.gz 08:53:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 08:53:01 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)) 08:53:01 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)) 08:53:01 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)) 08:53:01 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)) 08:53:01 INFO - Installing collected packages: marionette-driver 08:53:01 INFO - Running setup.py install for marionette-driver 08:53:01 INFO - Successfully installed marionette-driver 08:53:01 INFO - Cleaning up... 08:53:01 INFO - Return code: 0 08:53:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:53:01 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')]} 08:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:01 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')]} 08:53:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:01 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 0x175b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1928a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ace5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acb7a0>, '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 0x1acc6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1accb30>, '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': 'c6927cf182745ad25b1d38b9000001fe-1495720935.175755-1451179319', '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 08:53:01 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 08:53:01 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 08:53:01 INFO - Using env: {'DISPLAY': ':0', 08:53:01 INFO - 'HOME': '/home/cltbld', 08:53:01 INFO - 'LANG': 'en_US.UTF-8', 08:53:01 INFO - 'LANGUAGE': 'en_US:en', 08:53:01 INFO - 'LOGNAME': 'cltbld', 08:53:01 INFO - 'MAIL': '/var/mail/cltbld', 08:53:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:01 INFO - 'MOZ_NO_REMOTE': '1', 08:53:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:01 INFO - 'NO_EM_RESTART': '1', 08:53:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:01 INFO - 'PWD': '/builds/slave/test', 08:53:01 INFO - 'SHELL': '/bin/bash', 08:53:01 INFO - 'SHLVL': '1', 08:53:01 INFO - 'TERM': 'linux', 08:53:01 INFO - 'TMOUT': '86400', 08:53:01 INFO - 'USER': 'cltbld', 08:53:01 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1495720935.175755-1451179319', 08:53:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:01 INFO - '_': '/tools/buildbot/bin/python'} 08:53:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:53:01 INFO - Cleaning up... 08:53:01 INFO - Return code: 0 08:53:01 INFO - Running post-action listener: _resource_record_post_action 08:53:01 INFO - Running post-action listener: _start_resource_monitoring 08:53:01 INFO - Starting resource monitoring. 08:53:01 INFO - [mozharness: 2017-05-25 15:53:01.431714Z] Finished create-virtualenv step (success) 08:53:01 INFO - [mozharness: 2017-05-25 15:53:01.432636Z] Running install step. 08:53:01 INFO - Running pre-action listener: _resource_record_pre_action 08:53:01 INFO - Running main action method: install 08:53:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:53:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:53:01 INFO - Reading from file tmpfile_stdout 08:53:01 INFO - Detecting whether we're running mozinstall >=1.0... 08:53:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:53:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:53:01 INFO - Reading from file tmpfile_stdout 08:53:01 INFO - Output received: 08:53:01 INFO - Usage: mozinstall [options] installer 08:53:01 INFO - Options: 08:53:01 INFO - -h, --help show this help message and exit 08:53:01 INFO - -d DEST, --destination=DEST 08:53:01 INFO - Directory to install application into. [default: 08:53:01 INFO - "/builds/slave/test"] 08:53:01 INFO - --app=APP Application being installed. [default: firefox] 08:53:01 INFO - mkdir: /builds/slave/test/build/application 08:53:01 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'] 08:53:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:53:17 INFO - Reading from file tmpfile_stdout 08:53:17 INFO - Output received: 08:53:17 INFO - /builds/slave/test/build/application/firefox/firefox 08:53:17 INFO - Running post-action listener: _resource_record_post_action 08:53:17 INFO - [mozharness: 2017-05-25 15:53:17.262008Z] Finished install step (success) 08:53:17 INFO - [mozharness: 2017-05-25 15:53:17.262285Z] Running run-tests step. 08:53:17 INFO - Running pre-action listener: _resource_record_pre_action 08:53:17 INFO - Running main action method: run_tests 08:53:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:53:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:53:17 INFO - Python 2.7.3 08:53:17 INFO - Return code: 0 08:53:17 INFO - grabbing minidump binary from tooltool 08:53:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:17 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 0x1acb7a0>, '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 0x1acc6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1accb30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:53:17 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 08:53:17 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 08:53:17 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 08:53:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:53:17 INFO - Return code: 0 08:53:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:53:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:53:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:53:17 INFO - ENV: RUST_BACKTRACE is now 1 08:53:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:53:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:53:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qr857TJ7Qg2wIq7dexMhkw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 08:53:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Qr857TJ7Qg2wIq7dexMhkw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-004 --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 08:53:17 INFO - Using env: {'DISPLAY': ':0', 08:53:17 INFO - 'HOME': '/home/cltbld', 08:53:17 INFO - 'LANG': 'en_US.UTF-8', 08:53:17 INFO - 'LANGUAGE': 'en_US:en', 08:53:17 INFO - 'LOGNAME': 'cltbld', 08:53:17 INFO - 'MAIL': '/var/mail/cltbld', 08:53:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:53:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:53:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:17 INFO - 'MOZ_NO_REMOTE': '1', 08:53:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:53:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:17 INFO - 'NO_EM_RESTART': '1', 08:53:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:17 INFO - 'PWD': '/builds/slave/test', 08:53:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:53:17 INFO - 'RUST_BACKTRACE': '1', 08:53:17 INFO - 'SHELL': '/bin/bash', 08:53:17 INFO - 'SHLVL': '1', 08:53:17 INFO - 'TERM': 'linux', 08:53:17 INFO - 'TMOUT': '86400', 08:53:17 INFO - 'USER': 'cltbld', 08:53:17 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1495720935.175755-1451179319', 08:53:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:17 INFO - '_': '/tools/buildbot/bin/python'} 08:53:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qr857TJ7Qg2wIq7dexMhkw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 08:53:17 INFO - mozversion application_buildid: 20170525151914 08:53:17 INFO - mozversion application_changeset: f7adbf457ee20eeffde72694e0d17d73616e3cfd 08:53:17 INFO - mozversion application_display_name: Nightly 08:53:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:53:17 INFO - mozversion application_name: Firefox 08:53:17 INFO - mozversion application_remotingname: firefox 08:53:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:53:17 INFO - mozversion application_vendor: Mozilla 08:53:17 INFO - mozversion application_version: 55.0a1 08:53:17 INFO - mozversion platform_buildid: 20170525151914 08:53:17 INFO - mozversion platform_changeset: f7adbf457ee20eeffde72694e0d17d73616e3cfd 08:53:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:53:17 INFO - mozversion platform_version: 55.0a1 08:53:17 INFO - using testdate: 1495727597 08:53:17 INFO - actual date: 1495727597 08:53:17 INFO - starting webserver on 'localhost:58190' 08:53:17 INFO - SUITE-START | Running 2 tests 08:53:17 INFO - TEST-START | dromaeo_css 08:53:17 INFO - operating with platform_type : linux_ 08:53:17 INFO - Initialising browser for dromaeo_css test... 08:53:17 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58190/getInfo.html -profile /tmp/tmp9i3YDf/profile 08:53:17 INFO - TEST-INFO | started process 3351 (/builds/slave/test/build/application/firefox/firefox http://localhost:58190/getInfo.html) 08:53:54 INFO - TEST-INFO | 3351: killed by SIGTERM 08:53:54 INFO - Browser initialized. 08:53:54 INFO - Running cycle 1/1 for dromaeo_css test... 08:53:54 INFO - TEST-INFO | started process 3549 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9i3YDf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:54:06 INFO - PID 3549 | RSS: Main: 172404736 08:54:06 INFO - PID 3549 | 08:57:11 INFO - PID 3549 | Cycle 1(1): loaded http://localhost:58190/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58190/tests/dromaeo/cssquery-ext.html) 08:57:12 INFO - PID 3549 | RSS: Main: 170217472 08:57:12 INFO - PID 3549 | 09:00:14 INFO - PID 3549 | Cycle 1(1): loaded http://localhost:58190/tests/dromaeo/cssquery-ext.html (next: http://localhost:58190/tests/dromaeo/cssquery-jquery.html) 09:00:15 INFO - PID 3549 | RSS: Main: 175919104 09:00:15 INFO - PID 3549 | 09:03:16 INFO - PID 3549 | Cycle 1(1): loaded http://localhost:58190/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58190/tests/dromaeo/cssquery-mootools.html) 09:03:17 INFO - PID 3549 | RSS: Main: 174391296 09:03:17 INFO - PID 3549 | 09:06:19 INFO - PID 3549 | Cycle 1(1): loaded http://localhost:58190/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58190/tests/dromaeo/cssquery-prototype.html) 09:06:19 INFO - PID 3549 | RSS: Main: 178294784 09:06:19 INFO - PID 3549 | 09:09:22 INFO - PID 3549 | Cycle 1(1): loaded http://localhost:58190/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58190/tests/dromaeo/cssquery-yui.html) 09:09:23 INFO - PID 3549 | RSS: Main: 176459776 09:09:23 INFO - PID 3549 | 09:12:24 INFO - PID 3549 | Cycle 1(1): loaded http://localhost:58190/tests/dromaeo/cssquery-yui.html (next: http://localhost:58190/tests/dromaeo/cssquery-dojo.html) 09:12:25 INFO - PID 3549 | RSS: Main: 174944256 09:12:25 INFO - PID 3549 | 09:12:25 INFO - PID 3549 | __start_tp_report 09:12:25 INFO - PID 3549 | _x_x_mozilla_page_load 09:12:25 INFO - PID 3549 | _x_x_mozilla_page_load_details 09:12:25 INFO - PID 3549 | |i|pagename|runs| 09:12:25 INFO - PID 3549 | |0;dojo.html;2706.2422521693925;2725.1960671601873;2731.4946734854043;2755.944881102378;2757.076379412897;5105.18317069269;5225.216217567367;5246.422893481718;5257.658252213609;5311.309529761131;5194.402643695976;5208.036513245052;5216.530512253897;5302.734863256831;5315.229291752694;4621.260598304264;4653.697509661861;4663.067386522709;4690.343351930733;4709.811607535712;4524.095180963804;4637.582617564419;4661.394018777554;4671.976640116794;4725.149473094859;4557.521460246659;4637.1421287062;4649.325847752091;4704.200285951397;4752.1921273383605;4585.931211031804;4618.468876079261;4621.907561848778;4690.249560070372;4692.788824502905;4575.245084561044;4598.4711758147905;4617.376654151713;4632.235681112612;4662.277347011219;5115.667481613683;5168.173092305251;5186.948130518685;5212.843614691527;5219.164933610642;5552.444755524456;5658.632188907749;5713.171590119409;5721.828345149652;5738.512226460756;5688.203651488795;5721.256236689245;5724.055530837407;5738.6556806591325;5756.194132821408;5270.998510283034;5285.867853303698;5287.41838397776;5291.497307755719;5366.060939335601;5638.661680299195;5698.629589076697;5707.429257074343;5766.048601980626;5815.709214539256;5583.609147359727;5621.578381621313;5622.437756224344;5622.437756224426;5639.887202256014;5653.519450846724;5679.971600141973;5686.715664216773;5687.772489100473;5692.430756924357;5525.668459892419;5549.334079910436;5656.8868622627315;5666.065099258659;5679.034564124109;5521.613487055867;5580.637258578179;5644.322681278273;5656.123300888369;5665.801696940587;4761.666683332202;4766.880827979328;4787.569118779257;4792.496787837296;4830.372051633335;3980.5024371953505;4076.9388459173138;4087.591240875948;4117.773522456234;4127.050778321003;4749.1926372516755;4780.402449693788;4796;4808.2787581863;4835.782389792468;5631.155326701028;5637.746301416446;5687.232223649754;5693.231413759089;5721.342045664718;4781.8284520292755;4783.976080119577;4813.975930120397;4827.782749776268;4860.586850117709;4802.711837289774;4874.658773885794;4878.390201224847;4954.761309672582;4959.603231741452;5279.736013199402;5284.841454756363;5289.312389389354;5323.148296272732;5336.092864213016;5565.1374037024325;5634.633748806478;5682.062459694104;5685.658860468385;5688.288963879515;5240.895182096413;5253.763580638804;5255.842324730112;5340.252364669027;5353.4646535346155;5511.476409741068;5561.443855614568;5594.804181853616;5621.100623900156;5676.631018983753;5578.6611213309325;5637.661740295595;5653.689047102284;5663.66018038919;5731.19763233156;5474.644148130359;5542.0301447247375;5551.528120109674;5583.162525621027;5592.161175823497;5521.1442226454965;5533.114701647717;5548.334199895877;5550.38945715979;5555;5349.919751203813;5417.133258678593;5421.972890135524;5482.418931462316;5523.309586301712;5505.229267902577;5545.223668686306;5564.165375193753;5571.359293681278;5602.551795856403;5435.483629055233;5448.645838020516;5455.18172274162;5457.181422786613;5461.0716178248995 09:12:25 INFO - PID 3549 | |1;ext.html;690.7029977109844;721.9314165154309;737.5943231222827;1053.4153544782648;1071.6892101290625;31560.368792624133;32369.659006263966;32370.514442283384;32425.837870810672;32524.186895327628;33263.667363326356;33347;33636;33686;33722.1569460763;6351.682415879211;6731.629760363166;6856.897146542806;6857.417119544844;6868.519203655746;6373.71318290678;6459;6468.676566171696;6470.191226096738;6476;6402.391772781578;6473.1261279727105;6474.255460622018;6478.708458119396;6489.643069631168;6417.390347916964;6441.452476539476;6478.319776423502;6478.514111441637;6491.610503369766;6464.676766161673;6470.4823614110755;6490.707918143695;6497.837554061139;6522.510811689142;29658.55512167319;29844.70155298441;29868.8506557468;29940.850295748598;30009.849950750107;2954.2023653613405;2961.6001839751575;2964.970350296491;2975.5834183214365;2987.507061334877;23287.883560582257;23377.76622233773;23482.178123765585;23516;23581.88209058961;2547.1339744486963;2549.668543089405;2571.434284457416;2579.0328626764963;2581.9483610327875;141053;142052.28973855064;142736;146047;151380;37631;37786.244275114346;37810.62189378126;37847.243055138744;37882.81058594689;39129.41305880414;39136.21727565433;39234;39322.72529582037;39367.40948885769;12842.165259258118;12922.030847686461;12960.222386656831;12963.935180324039;12964.675883102998;10441.060304572626;10447.268691191544;10448.791024179625;10473.109785668152;10477.528511217013;12320.199187052813;12332;12357.567485138157;12392.194507356993;12591.622251332476;5390.164524498709;5423;5423.755930983115;5429.131338985743;5523.613347065667;863.8013256950936;911.5487833522317;920.9723708288763;923.1507013547553;944.9669261575812;19906.203751850055;20708.068136933874;20918.372448826558;21144.471388215417;21153.25963591298;995.2286977592279;995.2684776689127;998.4907697074399;999.7950420163849;1009.3893194617151;10343.741406464898;13854.238016909167;14284.785728214085;14455.349509272108;14472;173897;174099;174476;175307;175713.55007724004;41745;42161;42438.151236975085;42485.362719559234;42531;1212.9393530323448;1260.8739126087319;1266.1769849597836;1266.3351740336213;1267.7464507098432;22467.43831404228;23236.3029109127;24284.63573046441;24351.14770983007;24605.38486537851;28848.2787930295;28923.7107628921;28978.27554311159;29020.12939611815;29061.7093829059;152567;153242;153283.23358383583;153585;154016.22991885417;27298.81609471198;27543.724562754116;27857.72142278551;29431.85284073566;29641;35703.82148089243;35976.280474390886;35991.64008359988;36037.81981090078;36205.81897090498;25895.741042590085;26962.19113426522;26979.730202697723;27127;27564.724352756217;26180.095539819755;26885.462290754465;27276.863615681796;27376.863115684293;28072.43855122927;30401.69598303989;30469.847650761603;30473.23816904595;30620.540691890084;30665;26264.21207363782;26405.60391594166;26683;27224.455510890068;27895.72104278931;21026.47433814167;22014.33956981293;22038.779612203674;22316.66525002094;22334.88832555827 09:12:25 INFO - PID 3549 | |2;jquery.html;400.43138742984956;412.9752214867106;418.11985769954237;428.52433798483685;429.57042957042955;14297.78553321701;15196.088234705925;17134.91432542837;17770.111494425277;17799.199036043377;18089.7286540702;18548.907255463702;18619.627607447845;18759.906200469013;18950.147243374046;5252.763625636855;5393.81121660742;5518.475744804237;5523.6409633373705;5534.197541356501;4900.166971614816;5020.573251273646;5044.319016932722;5054.848354549351;5062.190049592066;4908.092002979461;4990.026944745776;5185.144451165572;5224.164133738603;5263.842084737464;5132.871678208037;5139.460356662571;5159.974200128994;5163.3545806774155;5170.689758614495;4633.582977532004;4668.766561671903;4674.602658774008;4704.741239231841;4754.239321708545;21493.57012859734;21644.675329870064;21705.782942170692;21766.34700958974;21930.342089737333;1594.7687585300066;1616.030381770928;1617.0701846438344;1617.9191040447931;1624.398972380227;14078.22569758663;14245.715085698332;14247.430102795875;14521.636959076002;14544.27278636064;2020.2121172742643;2049.7130401743766;2071.5546157576196;2078.5738923520794;2082.2191678120703;81401.9999999994;85850.99999999937;88675;90463;92118.53940730254;10515.26393152472;10622;10897.29167604119;10995.230333876552;11168.553257869757;15327.31027103783;15510.922445387701;15516.689666206612;15555.766663500057;15565.533034008999;7398.96300518494;7491.66287517063;7614.771556853303;7673.271039251262;7698.461107722517;6900.206476255295;7023.416281288956;7146.428285737128;7206.963965180141;7212.891806622905;6691.089376121403;6873.965630171817;6919.204291506541;6923.515353925177;6929.237783843773;2076.958460830775;2086.2593779208164;2099.937001889946;2109.7468303803334;2229.152921889704;816.3673153306236;870.1559487297311;887.9689210877589;903.3631289940577;914.0356923445828;16690.165491725365;16797.076160811273;16914.06972616518;17194.054327011883;17575;862.0904945282787;867.5705525764787;868.3227082875368;878.4202426398547;890.3544929925752;9187.816243675223;9188.63245470187;9472.479013654178;9529.52352382392;9575.712728618153;356075.196240187;359662;361039;365097;365533;74612.92725481991;78331.60834195792;78495.21504784879;78651;78852;1019.4444028004755;1027.9074883260541;1055.2693582524666;1059.4384975962753;1060.4644654449453;14384.568462946128;14546.781798272823;14680.55958321252;14707.67630913223;15198.924005379902;37201.4419783698;38528.614713853625;38623.42064868973;38663.58709780689;39389;47380;48586.27120593123;48741.268880967524;49518.257226140915;49835.75082124566;7982.920170798217;8016.9198308016175;8065.435419520577;8079.192080792109;8417.410781245255;10924.180686448708;11327.207095503236;11351.262167959056;11549.6535103947;11597.13021523406;9865.802683946424;10032.69901902944;10274;10362.948185259025;10667;9286.489243091695;9483.478408687313;9617.374870633386;9642.180414664552;9680.661176858775;9945.403275803475;10005;10308.381497110197;10354.534045968101;10807.621733239299;7727.188645192174;7750.651220695195;7826.256505631955;7834.608269586384;7885.5662938538935;9748.51257437111;9911.752206194902;9958.900410995797;10099.192064634959;10123.443210623192 09:12:25 INFO - PID 3549 | |3;mootools.html;1209.9455524501398;1272.1413046193818;1278.4630455208812;1281.9038572107095;1294.1587967820915;10036.146927511161;10552.050315471597;10555.525001374937;10904.127669786418;11247.437628118601;10834.187435942296;10968.396738179397;11057.612983545578;11079.72300692483;11145.387003714814;2169.2516081951703;2183.912643494258;2208.8785116818567;2226.065052677871;2228.19784877444;2143;2185.4864106934856;2200.262911924507;2209.0169874405897;2214.8671079735186;2095.8532902696816;2114.68279758036;2115.8730476171404;2122.3632910126976;2144.4531644430726;2090.19527481919;2100.684897265407;2108.7680355160996;2109.4409981354875;2111.039477037944;1997.5605366819277;2072.8445366597416;2076.6054449654516;2139.4330502416874;2213.9889300553555;10495.370277783357;10652.840207396895;10655.786884262272;10657.413842238673;10723.088537474325;5603.831885043455;5845.240118784531;5856.502197313233;5867.501262392701;5873.060310350366;2994.8502574871386;3121.812691238533;3171.349873275996;3187.059817353886;3196.680331966808;937.2221056523069;939.9389039712465;1020.4795554267303;1023.6417253961129;1050.14937900301;14830.851691483163;15172.24138793067;15197.848021519865;15294.694106117815;15368.846311536854;4877.122118018719;4965.354503914468;4971.328870602422;4988.700677959334;4992;12028.759424811455;12073.818892716616;12077.15459917815;12090.697732556757;12122.878771212352;5537.889242215214;5720.11338242573;5748.913766293509;5753.280839895013;5764.077747560454;5042.571381432619;5049.267856160836;5072.873178170502;5109.38687357512;5111.8722031948755;4154.539690780804;4224.1129362833535;4226.619604235633;4288.078063216423;4317.935230971538;1342.2483409290828;1402.382951501336;1405.9648508787157;1422.7012327411153;1424.7934049562755;656.3797211634959;676.2493632068498;680.73451353972;700.8913618389158;706.1349846438175;5497.835064948058;5556.805511807067;5708.65748055118;5735.139729040678;5787.160861675034;553.6318348298337;574.4083593898291;576.3314555116045;577.982660520185;580.5761793890483;4036.979815100906;4037.959620403817;4069.959300407017;4102.446169767103;4459.375687403766;13510.189388636516;13656.112352697042;14297.928510357382;14332.49836255747;14354.856451435351;13376.331183440789;13595.728085438235;13665.111767735065;13826.446942122202;13895.166290022631;7187.209406965125;7219.963900180465;7408.3332500074175;7411.66647500853;7429.44279179053;6437.420632143129;6597.175353080865;6646.235682896336;6745.898811517733;6918.201267670342;12374.566890158801;12455.439505222106;12684.429200685807;12685.365731713562;12767.361631918553;12587.74824503523;12847.421866016239;12857.67855803575;12897.290649014394;13008.739825203633;8143.144969778088;8385.874211886949;8399.790005249673;8424.452410593292;8436.24073833358;9333;9445.433274003582;9535.09416605449;9575.138237558653;9589.232861371212;8198.59007049657;8266.13205613426;8304.958475207586;8338.37462190326;8352.624131913957;8162.877556836534;8215.671373145007;8225.383096267684;8310.667573297;8410.327173825957;7526.02161718973;7563.9621801890635;7601.619919004138;7604.391648668204;7652.579108149105;5122.513361230677;5184.300119483822;5260.658057226268;5284.26020357158;5483.890322193613;5081.796728130834;5089.134847075932;5157.690538567698;5235.874287028307;5387 09:12:25 INFO - PID 3549 | |4;prototype.html;341.08418895266215;354.8651512425278;358.42293906810033;362.9473726309685;366.11400411005354;5404.729763511818;5498.862528436786;5502.147167189087;5522.751476183571;5531.502164805167;5325.840224793263;5401.972990135044;5406.83779486615;5416.891662166764;5419.756110975006;4066.857659981894;4076.2458945095104;4082.6733861291027;4090.7954602269915;4091.672666186698;3946.4080387941895;4060.8984775380554;4087.2847251730827;4095.365218391154;4115.773632450214;4045.271851066807;4050.129222217223;4050.979745101285;4065.8373665053364;4074;3993.420953961688;4019.075612609102;4019.718619696622;4032;4048.5951404859425;3509.613223239586;3521.8730006397964;3531.6644918732677;3535.1338921964025;3537.0449978505917;5251.4485978972425;5275.947240527584;5346.545543628797;5355.812546560891;5360.705161216131;4793.5925446337105;4810.470848206694;4835.492273311322;4843.515648435164;4865.586425153866;5628.493435590816;5768.192453056576;5785.190073389729;5785.768569257225;5800.7679692812235;3962.841486340543;3987.7208595398333;3988.581198974095;3994.660453861425;4006.4991876015497;5869.295684517842;6125.111858780452;6134.662593557353;6139.723712432907;6183.1961844960315;3965.365541513344;3967.781772002568;3968.464257325224;3971.907725375545;3973.8609148679657;3985.5416627087675;3989.5212574491247;3990.38149086892;4000.599940006034;4010.2781499329817;4565.76724284448;4696.412948381452;4704.647151463654;4708.929366059512;4710.940038491312;5805.796797112081;5806.593538452268;5837.357890632027;5846.766129354778;5865.67738774363;1405.3697710655795;1416.5113036002563;1418.198717724503;1419.921904295253;1420.9147451152758;898.5507246376811;942.0861764088822;949.4825320200507;953.3374304858196;958.736347504428;4998.175301075355;5001.349824522788;5043.142665746758;5047.570956468741;5092.465291144376;5940.34656187819;5953.940460595425;5969.164316995624;6034.818955431344;6044.637321760709;4874.610031197496;4995.650304478651;4998.650094493423;5017.3226614406585;5048.974755126201;3150.6061742282213;3175.9364812703616;3190.8512935343256;3191.4734068878374;3192;5439.918401223985;5535.474129957647;5537.529310008614;5552.972700050504;5583.525400341016;6004.729787159588;6091.695415229221;6134.478569321568;6167.506599472032;6174.845628859314;5540.168974653834;5551.583631227593;5564.888702225933;5565.777368905198;5582.330120385498;5772.393898640582;5926.644401335933;5945.940540594539;5986.2517185351835;6012.368701286477;5891.734871930859;5924.6149000314845;5930.043085781595;5933.970330148494;5939.891338574744;5355.491228333302;5569.10894256917;5594.915711530687;5594.944050559442;5600.467955544217;4034.91930161401;4050.7569545827346;4055.330870406468;4060.451839001815;4063.7764922929523;5897.64614123154;6015.488683461955;6047.395260473917;6057.1519987200945;6079.726412311368;5815.476607105212;5839.948809214382;5852.449100988327;5854.121881717776;5878.882422351615;5746.3966283541295;5803.448672376117;5812.82561523155;5825.3592104867585;5844.211031510692;5512.503874651301;5734.426557344233;5753.389051065708;5766.135079738073;5766.509846663081;5851.824445266649;5900.7049647518315;5903;5916.881662366643;5919.6152250103605;5466.781328746805;5683.658980461186;5713.600047996601;5713.628614140068;5738.196652468574 09:12:25 INFO - PID 3549 | |5;yui.html;745.9813504662385;759.7264984605541;761.7219714804098;766.455816370377;772.4708574626378;13299.401526931288;13626.727465450698;13724.24516651585;14892.180930048842;16197.595060123473;15224.010439321464;15384.076955382685;15384.692306153898;15440.768388474155;15447.073175609472;902.4585248850686;919.7700574856286;921.870938068671;922.7416323429451;927.3554879358849;918.1782304837167;921.5991043895926;923.6351641101761;925.6066171876926;925.8240934222509;904.1681652879333;944.9007854175316;954.766082309835;965.2133511188395;972.2562239886457;934.3226161033265;937.4562753602894;941.9058094190594;944.0748066894413;945.5461378538306;687.8693048320853;690.5614934516568;692.0380670867498;692.6225207262054;692.7679227458807;13794.517191898336;13885.097468664504;13931.164130152121;14015.229162396065;14051.71896562063;15086.321115549827;15959.281832317574;15962.441314554051;15999.360025598962;16098.83901160985;12302.138850280484;12385.504579816796;12406.007519398518;12444.502219911192;12461.688457788538;3008.2629755709772;3033.620797400325;3039.1794215561895;3046.7562594992346;3055.663876973531;82656.58671706663;84137.57931210365;84549.57725211335;84824;85521.57239213763;12106.576269830513;12173.756524869454;12371.412290435674;12380.690482737824;12493.750124997448;23716.64425033626;24738;24789.5042099157;24933.62599561008;24979.125730599342;6028.517718582503;6041.24484439445;6053.727582258809;6074.481379655086;6112.938870611237;2733.5079685656774;2828.3918957424253;2834.858257087137;2848.928776780597;2853.0727513558177;3445.8621655134016;3548.733844961638;3548.7515873889097;3571.339302229096;3575.856965721342;595.8778450417655;599.7031469422576;604.4439116013278;607.3076692570473;607.5534482155612;564.6527385657873;587.4037851580649;588.5909293041295;588.9469947704728;593.104412337365;9145.405548639317;9578.521073946275;9843.606255749834;10340.793184136275;10537.104346130665;541.1666034307201;550.7411516587198;560.3080195957989;562.3476766950319;580.089259862021;4418.425604671372;4546.840860569864;4562.178807814559;4598.747068911175;4698.906021879543;89463.71546084729;89845;90165.54917225504;90473;92208.53895730613;79755;79978;80452;81454.18545814585;81846.59076704578;58882;61323;62851;63061;66597.66701166463;9967.50162491887;10555.577776889146;10578.910063791003;11196.160287978271;11336.546538138382;27537;27642.308942276602;28208.576871347355;28829.99095031664;29142.854285728437;35032.82483587566;35387.82306088556;35663.82168089247;35929.46105808467;36300.81849590735;13073.15024523403;13249.536266230636;13323.067385282937;13479.056466047283;13587.116837405538;15901.125438101015;15981.600459988593;16057.518274451319;16062.598435039217;16250.918745406198;13509.59471215865;13716.245606491739;13782;13839;13973.441062357391;13746.381412836246;13818.516351927634;14326.641833954234;14348.354324055652;14551.126932384092;14219.857801422268;14521;14592.416303347747;14658.486952956595;15164.24178791034;10082.193424525874;10473.842892356774;10504.947475262576;10529.526171322155;10569.207309451667;10582.259241852997;11483.311001339946;12482.75034499323;12504.124711270124;12679.80980285278 09:12:25 INFO - PID 3549 | __end_tp_report 09:12:25 INFO - PID 3549 | __start_cc_report 09:12:25 INFO - PID 3549 | _x_x_mozilla_cycle_collect,347 09:12:25 INFO - PID 3549 | __end_cc_report 09:12:25 INFO - PID 3549 | __startTimestamp1495728745132__endTimestamp 09:12:25 INFO - PID 3549 | 09:12:25 INFO - PID 3549 | ------- Summary: start ------- 09:12:25 INFO - PID 3549 | Number of tests: 6 09:12:25 INFO - PID 3549 | 09:12:25 INFO - PID 3549 | [#0] dojo.html Cycles:165 Average:5171.12 Median:5340.25 stddev:612.88 (11.5%) stddev-sans-first:583.46 09:12:25 INFO - PID 3549 | Values: 2706.2 2725.2 2731.5 2755.9 2757.1 5105.2 5225.2 5246.4 5257.7 5311.3 5194.4 5208.0 5216.5 5302.7 5315.2 4621.3 4653.7 4663.1 4690.3 4709.8 4524.1 4637.6 4661.4 4672.0 4725.1 4557.5 4637.1 4649.3 4704.2 4752.2 4585.9 4618.5 4621.9 4690.2 4692.8 4575.2 4598.5 4617.4 4632.2 4662.3 5115.7 5168.2 5186.9 5212.8 5219.2 5552.4 5658.6 5713.2 5721.8 5738.5 5688.2 5721.3 5724.1 5738.7 5756.2 5271.0 5285.9 5287.4 5291.5 5366.1 5638.7 5698.6 5707.4 5766.0 5815.7 5583.6 5621.6 5622.4 5622.4 5639.9 5653.5 5680.0 5686.7 5687.8 5692.4 5525.7 5549.3 5656.9 5666.1 5679.0 5521.6 5580.6 5644.3 5656.1 5665.8 4761.7 4766.9 4787.6 4792.5 4830.4 3980.5 4076.9 4087.6 4117.8 4127.1 4749.2 4780.4 4796.0 4808.3 4835.8 5631.2 5637.7 5687.2 5693.2 5721.3 4781.8 4784.0 4814.0 4827.8 4860.6 4802.7 4874.7 4878.4 4954.8 4959.6 5279.7 5284.8 5289.3 5323.1 5336.1 5565.1 5634.6 5682.1 5685.7 5688.3 5240.9 5253.8 5255.8 5340.3 5353.5 5511.5 5561.4 5594.8 5621.1 5676.6 5578.7 5637.7 5653.7 5663.7 5731.2 5474.6 5542.0 5551.5 5583.2 5592.2 5521.1 5533.1 5548.3 5550.4 5555.0 5349.9 5417.1 5422.0 5482.4 5523.3 5505.2 5545.2 5564.2 5571.4 5602.6 5435.5 5448.6 5455.2 5457.2 5461.1 09:12:25 INFO - PID 3549 | 09:12:25 INFO - PID 3549 | [#1] ext.html Cycles:180 Average:29978.85 Median:29246.78 stddev:40730.57 (139.3%) stddev-sans-first:40785.45 09:12:25 INFO - PID 3549 | Values: 690.7 721.9 737.6 1053.4 1071.7 31560.4 32369.7 32370.5 32425.8 32524.2 33263.7 33347.0 33636.0 33686.0 33722.2 6351.7 6731.6 6856.9 6857.4 6868.5 6373.7 6459.0 6468.7 6470.2 6476.0 6402.4 6473.1 6474.3 6478.7 6489.6 6417.4 6441.5 6478.3 6478.5 6491.6 6464.7 6470.5 6490.7 6497.8 6522.5 29658.6 29844.7 29868.9 29940.9 30009.8 2954.2 2961.6 2965.0 2975.6 2987.5 23287.9 23377.8 23482.2 23516.0 23581.9 2547.1 2549.7 2571.4 2579.0 2581.9 141053.0 142052.3 142736.0 146047.0 151380.0 37631.0 37786.2 37810.6 37847.2 37882.8 39129.4 39136.2 39234.0 39322.7 39367.4 12842.2 12922.0 12960.2 12963.9 12964.7 10441.1 10447.3 10448.8 10473.1 10477.5 12320.2 12332.0 12357.6 12392.2 12591.6 5390.2 5423.0 5423.8 5429.1 5523.6 863.8 911.5 921.0 923.2 945.0 19906.2 20708.1 20918.4 21144.5 21153.3 995.2 995.3 998.5 999.8 1009.4 10343.7 13854.2 14284.8 14455.3 14472.0 173897.0 174099.0 174476.0 175307.0 175713.6 41745.0 42161.0 42438.2 42485.4 42531.0 1212.9 1260.9 1266.2 1266.3 1267.7 22467.4 23236.3 24284.6 24351.1 24605.4 28848.3 28923.7 28978.3 29020.1 29061.7 152567.0 153242.0 153283.2 153585.0 154016.2 27298.8 27543.7 27857.7 29431.9 29641.0 35703.8 35976.3 35991.6 36037.8 36205.8 25895.7 26962.2 26979.7 27127.0 27564.7 26180.1 26885.5 27276.9 27376.9 28072.4 30401.7 30469.8 30473.2 30620.5 30665.0 26264.2 26405.6 26683.0 27224.5 27895.7 21026.5 22014.3 22038.8 22316.7 22334.9 09:12:25 INFO - PID 3549 | 09:12:25 INFO - PID 3549 | [#2] jquery.html Cycles:180 Average:24335.15 Median:4651.17 stddev:60303.87 (1296.5%) stddev-sans-first:60446.26 09:12:25 INFO - PID 3549 | Values: 400.4 413.0 418.1 428.5 429.6 14297.8 15196.1 17134.9 17770.1 17799.2 18089.7 18548.9 18619.6 18759.9 18950.1 5252.8 5393.8 5518.5 5523.6 5534.2 4900.2 5020.6 5044.3 5054.8 5062.2 4908.1 4990.0 5185.1 5224.2 5263.8 5132.9 5139.5 5160.0 5163.4 5170.7 4633.6 4668.8 4674.6 4704.7 4754.2 21493.6 21644.7 21705.8 21766.3 21930.3 1594.8 1616.0 1617.1 1617.9 1624.4 14078.2 14245.7 14247.4 14521.6 14544.3 2020.2 2049.7 2071.6 2078.6 2082.2 81402.0 85851.0 88675.0 90463.0 92118.5 10515.3 10622.0 10897.3 10995.2 11168.6 15327.3 15510.9 15516.7 15555.8 15565.5 7399.0 7491.7 7614.8 7673.3 7698.5 6900.2 7023.4 7146.4 7207.0 7212.9 6691.1 6874.0 6919.2 6923.5 6929.2 2077.0 2086.3 2099.9 2109.7 2229.2 816.4 870.2 888.0 903.4 914.0 16690.2 16797.1 16914.1 17194.1 17575.0 862.1 867.6 868.3 878.4 890.4 9187.8 9188.6 9472.5 9529.5 9575.7 356075.2 359662.0 361039.0 365097.0 365533.0 74612.9 78331.6 78495.2 78651.0 78852.0 1019.4 1027.9 1055.3 1059.4 1060.5 14384.6 14546.8 14680.6 14707.7 15198.9 37201.4 38528.6 38623.4 38663.6 39389.0 47380.0 48586.3 48741.3 49518.3 49835.8 7982.9 8016.9 8065.4 8079.2 8417.4 10924.2 11327.2 11351.3 11549.7 11597.1 9865.8 10032.7 10274.0 10362.9 10667.0 9286.5 9483.5 9617.4 9642.2 9680.7 9945.4 10005.0 10308.4 10354.5 10807.6 7727.2 7750.7 7826.3 7834.6 7885.6 9748.5 9911.8 9958.9 10099.2 10123.4 09:12:25 INFO - PID 3549 | 09:12:25 INFO - PID 3549 | [#3] mootools.html Cycles:180 Average:6486.60 Median:4086.20 stddev:4250.85 (104.0%) stddev-sans-first:4244.29 09:12:25 INFO - PID 3549 | Values: 1209.9 1272.1 1278.5 1281.9 1294.2 10036.1 10552.1 10555.5 10904.1 11247.4 10834.2 10968.4 11057.6 11079.7 11145.4 2169.3 2183.9 2208.9 2226.1 2228.2 2143.0 2185.5 2200.3 2209.0 2214.9 2095.9 2114.7 2115.9 2122.4 2144.5 2090.2 2100.7 2108.8 2109.4 2111.0 1997.6 2072.8 2076.6 2139.4 2214.0 10495.4 10652.8 10655.8 10657.4 10723.1 5603.8 5845.2 5856.5 5867.5 5873.1 2994.9 3121.8 3171.3 3187.1 3196.7 937.2 939.9 1020.5 1023.6 1050.1 14830.9 15172.2 15197.8 15294.7 15368.8 4877.1 4965.4 4971.3 4988.7 4992.0 12028.8 12073.8 12077.2 12090.7 12122.9 5537.9 5720.1 5748.9 5753.3 5764.1 5042.6 5049.3 5072.9 5109.4 5111.9 4154.5 4224.1 4226.6 4288.1 4317.9 1342.2 1402.4 1406.0 1422.7 1424.8 656.4 676.2 680.7 700.9 706.1 5497.8 5556.8 5708.7 5735.1 5787.2 553.6 574.4 576.3 578.0 580.6 4037.0 4038.0 4070.0 4102.4 4459.4 13510.2 13656.1 14297.9 14332.5 14354.9 13376.3 13595.7 13665.1 13826.4 13895.2 7187.2 7220.0 7408.3 7411.7 7429.4 6437.4 6597.2 6646.2 6745.9 6918.2 12374.6 12455.4 12684.4 12685.4 12767.4 12587.7 12847.4 12857.7 12897.3 13008.7 8143.1 8385.9 8399.8 8424.5 8436.2 9333.0 9445.4 9535.1 9575.1 9589.2 8198.6 8266.1 8305.0 8338.4 8352.6 8162.9 8215.7 8225.4 8310.7 8410.3 7526.0 7564.0 7601.6 7604.4 7652.6 5122.5 5184.3 5260.7 5284.3 5483.9 5081.8 5089.1 5157.7 5235.9 5387.0 09:12:25 INFO - PID 3549 | 09:12:25 INFO - PID 3549 | [#4] prototype.html Cycles:180 Average:4738.68 Median:5418.32 stddev:1434.02 (26.5%) stddev-sans-first:1399.54 09:12:25 INFO - PID 3549 | Values: 341.1 354.9 358.4 362.9 366.1 5404.7 5498.9 5502.1 5522.8 5531.5 5325.8 5402.0 5406.8 5416.9 5419.8 4066.9 4076.2 4082.7 4090.8 4091.7 3946.4 4060.9 4087.3 4095.4 4115.8 4045.3 4050.1 4051.0 4065.8 4074.0 3993.4 4019.1 4019.7 4032.0 4048.6 3509.6 3521.9 3531.7 3535.1 3537.0 5251.4 5275.9 5346.5 5355.8 5360.7 4793.6 4810.5 4835.5 4843.5 4865.6 5628.5 5768.2 5785.2 5785.8 5800.8 3962.8 3987.7 3988.6 3994.7 4006.5 5869.3 6125.1 6134.7 6139.7 6183.2 3965.4 3967.8 3968.5 3971.9 3973.9 3985.5 3989.5 3990.4 4000.6 4010.3 4565.8 4696.4 4704.6 4708.9 4710.9 5805.8 5806.6 5837.4 5846.8 5865.7 1405.4 1416.5 1418.2 1419.9 1420.9 898.6 942.1 949.5 953.3 958.7 4998.2 5001.3 5043.1 5047.6 5092.5 5940.3 5953.9 5969.2 6034.8 6044.6 4874.6 4995.7 4998.7 5017.3 5049.0 3150.6 3175.9 3190.9 3191.5 3192.0 5439.9 5535.5 5537.5 5553.0 5583.5 6004.7 6091.7 6134.5 6167.5 6174.8 5540.2 5551.6 5564.9 5565.8 5582.3 5772.4 5926.6 5945.9 5986.3 6012.4 5891.7 5924.6 5930.0 5934.0 5939.9 5355.5 5569.1 5594.9 5594.9 5600.5 4034.9 4050.8 4055.3 4060.5 4063.8 5897.6 6015.5 6047.4 6057.2 6079.7 5815.5 5839.9 5852.4 5854.1 5878.9 5746.4 5803.4 5812.8 5825.4 5844.2 5512.5 5734.4 5753.4 5766.1 5766.5 5851.8 5900.7 5903.0 5916.9 5919.6 5466.8 5683.7 5713.6 5713.6 5738.2 09:12:25 INFO - PID 3549 | 09:12:25 INFO - PID 3549 | [#5] yui.html Cycles:180 Average:17573.73 Median:3250.76 stddev:23680.45 (728.5%) stddev-sans-first:23713.17 09:12:25 INFO - PID 3549 | Values: 746.0 759.7 761.7 766.5 772.5 13299.4 13626.7 13724.2 14892.2 16197.6 15224.0 15384.1 15384.7 15440.8 15447.1 902.5 919.8 921.9 922.7 927.4 918.2 921.6 923.6 925.6 925.8 904.2 944.9 954.8 965.2 972.3 934.3 937.5 941.9 944.1 945.5 687.9 690.6 692.0 692.6 692.8 13794.5 13885.1 13931.2 14015.2 14051.7 15086.3 15959.3 15962.4 15999.4 16098.8 12302.1 12385.5 12406.0 12444.5 12461.7 3008.3 3033.6 3039.2 3046.8 3055.7 82656.6 84137.6 84549.6 84824.0 85521.6 12106.6 12173.8 12371.4 12380.7 12493.8 23716.6 24738.0 24789.5 24933.6 24979.1 6028.5 6041.2 6053.7 6074.5 6112.9 2733.5 2828.4 2834.9 2848.9 2853.1 3445.9 3548.7 3548.8 3571.3 3575.9 595.9 599.7 604.4 607.3 607.6 564.7 587.4 588.6 588.9 593.1 9145.4 9578.5 9843.6 10340.8 10537.1 541.2 550.7 560.3 562.3 580.1 4418.4 4546.8 4562.2 4598.7 4698.9 89463.7 89845.0 90165.5 90473.0 92208.5 79755.0 79978.0 80452.0 81454.2 81846.6 58882.0 61323.0 62851.0 63061.0 66597.7 9967.5 10555.6 10578.9 11196.2 11336.5 27537.0 27642.3 28208.6 28830.0 29142.9 35032.8 35387.8 35663.8 35929.5 36300.8 13073.2 13249.5 13323.1 13479.1 13587.1 15901.1 15981.6 16057.5 16062.6 16250.9 13509.6 13716.2 13782.0 13839.0 13973.4 13746.4 13818.5 14326.6 14348.4 14551.1 14219.9 14521.0 14592.4 14658.5 15164.2 10082.2 10473.8 10504.9 10529.5 10569.2 10582.3 11483.3 12482.8 12504.1 12679.8 09:12:25 INFO - PID 3549 | -------- Summary: end -------- 09:12:25 INFO - PID 3549 | 09:12:25 INFO - TEST-INFO | 3549: exit 0 09:12:25 INFO - TEST-OK | dromaeo_css | took 1148250ms 09:12:25 INFO - TEST-START | kraken 09:12:25 INFO - operating with platform_type : linux_ 09:12:25 INFO - Initialising browser for kraken test... 09:12:25 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58190/getInfo.html -profile /tmp/tmptOn_IH/profile 09:12:25 INFO - TEST-INFO | started process 3953 (/builds/slave/test/build/application/firefox/firefox http://localhost:58190/getInfo.html) 09:13:00 INFO - TEST-INFO | 3953: killed by SIGTERM 09:13:00 INFO - Browser initialized. 09:13:00 INFO - Running cycle 1/1 for kraken test... 09:13:00 INFO - TEST-INFO | started process 4151 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptOn_IH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:13:12 INFO - PID 4151 | RSS: Main: 172863488 09:13:12 INFO - PID 4151 | 09:13:15 INFO - PID 4151 | Cycle 1(1): loaded http://localhost:58190/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58190/tests/kraken/driver.html?testName=audio-beat-detection) 09:13:16 INFO - PID 4151 | RSS: Main: 178495488 09:13:16 INFO - PID 4151 | 09:13:19 INFO - PID 4151 | Cycle 1(1): loaded http://localhost:58190/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58190/tests/kraken/driver.html?testName=audio-dft) 09:13:19 INFO - PID 4151 | RSS: Main: 177614848 09:13:19 INFO - PID 4151 | 09:13:22 INFO - PID 4151 | Cycle 1(1): loaded http://localhost:58190/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58190/tests/kraken/driver.html?testName=audio-fft) 09:13:23 INFO - PID 4151 | RSS: Main: 175554560 09:13:23 INFO - PID 4151 | 09:13:25 INFO - PID 4151 | Cycle 1(1): loaded http://localhost:58190/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58190/tests/kraken/driver.html?testName=audio-oscillator) 09:13:25 INFO - PID 4151 | RSS: Main: 175894528 09:13:25 INFO - PID 4151 | 09:13:27 INFO - PID 4151 | Cycle 1(1): loaded http://localhost:58190/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58190/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:13:28 INFO - PID 4151 | RSS: Main: 176193536 09:13:28 INFO - PID 4151 | 09:13:31 INFO - PID 4151 | Cycle 1(1): loaded http://localhost:58190/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58190/tests/kraken/driver.html?testName=imaging-darkroom) 09:13:32 INFO - PID 4151 | RSS: Main: 177188864 09:13:32 INFO - PID 4151 | 09:13:35 INFO - PID 4151 | Cycle 1(1): loaded http://localhost:58190/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58190/tests/kraken/driver.html?testName=imaging-desaturate) 09:13:36 INFO - PID 4151 | RSS: Main: 175845376 09:13:36 INFO - PID 4151 | 09:13:39 INFO - PID 4151 | Cycle 1(1): loaded http://localhost:58190/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58190/tests/kraken/driver.html?testName=json-parse-financial) 09:13:40 INFO - PID 4151 | RSS: Main: 176918528 09:13:40 INFO - PID 4151 | 09:13:41 INFO - PID 4151 | Cycle 1(1): loaded http://localhost:58190/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58190/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:13:42 INFO - PID 4151 | RSS: Main: 176869376 09:13:42 INFO - PID 4151 | 09:13:44 INFO - PID 4151 | Cycle 1(1): loaded http://localhost:58190/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58190/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:13:44 INFO - PID 4151 | RSS: Main: 176865280 09:13:44 INFO - PID 4151 | 09:13:46 INFO - PID 4151 | Cycle 1(1): loaded http://localhost:58190/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58190/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:13:47 INFO - PID 4151 | RSS: Main: 177360896 09:13:47 INFO - PID 4151 | 09:13:50 INFO - PID 4151 | Cycle 1(1): loaded http://localhost:58190/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58190/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:13:51 INFO - PID 4151 | RSS: Main: 176934912 09:13:51 INFO - PID 4151 | 09:13:54 INFO - PID 4151 | Cycle 1(1): loaded http://localhost:58190/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58190/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:13:54 INFO - PID 4151 | RSS: Main: 176963584 09:13:54 INFO - PID 4151 | 09:13:56 INFO - PID 4151 | Cycle 1(1): loaded http://localhost:58190/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58190/tests/kraken/driver.html?testName=ai-astar) 09:13:56 INFO - PID 4151 | RSS: Main: 178442240 09:13:56 INFO - PID 4151 | 09:13:56 INFO - PID 4151 | __start_tp_report 09:13:56 INFO - PID 4151 | _x_x_mozilla_page_load 09:13:56 INFO - PID 4151 | _x_x_mozilla_page_load_details 09:13:56 INFO - PID 4151 | |i|pagename|runs| 09:13:56 INFO - PID 4151 | |0;ai-astar;104;112;113;113;113;116;114;114;112;116 09:13:56 INFO - PID 4151 | |1;audio-beat-detection;152;124;126;175;130;123;124;122;145;125 09:13:56 INFO - PID 4151 | |2;audio-dft;166;164;163;164;169;168;168;163;162;163 09:13:56 INFO - PID 4151 | |3;audio-fft;75;74;75;100;74;74;75;74;98;74 09:13:56 INFO - PID 4151 | |4;audio-oscillator;84;84;101;83;83;83;97;83;84;102 09:13:56 INFO - PID 4151 | |5;imaging-gaussian-blur;114;115;114;115;115;115;114;115;115;114 09:13:56 INFO - PID 4151 | |6;imaging-darkroom;154;151;152;151;151;150;151;151;150;150 09:13:56 INFO - PID 4151 | |7;imaging-desaturate;95;96;95;95;94;95;95;96;94;94 09:13:56 INFO - PID 4151 | |8;json-parse-financial;56;54;54;56;55;58;55;59;55;56 09:13:56 INFO - PID 4151 | |9;json-stringify-tinderbox;58;58;58;58;58;58;58;57;57;58 09:13:56 INFO - PID 4151 | |10;stanford-crypto-aes;89;86;96;88;86;88;88;89;113;87 09:13:56 INFO - PID 4151 | |11;stanford-crypto-ccm;139;136;138;137;135;136;135;145;149;144 09:13:56 INFO - PID 4151 | |12;stanford-crypto-pbkdf2;191;192;199;211;202;199;197;194;197;198 09:13:56 INFO - PID 4151 | |13;stanford-crypto-sha256-iterative;75;74;73;73;74;72;72;72;74;73 09:13:56 INFO - PID 4151 | __end_tp_report 09:13:56 INFO - PID 4151 | __start_cc_report 09:13:56 INFO - PID 4151 | _x_x_mozilla_cycle_collect,901 09:13:56 INFO - PID 4151 | __end_cc_report 09:13:56 INFO - PID 4151 | __startTimestamp1495728836927__endTimestamp 09:13:56 INFO - PID 4151 | 09:13:56 INFO - PID 4151 | ------- Summary: start ------- 09:13:56 INFO - PID 4151 | Number of tests: 14 09:13:56 INFO - PID 4151 | 09:13:56 INFO - PID 4151 | [#0] ai-astar Cycles:10 Average:112.70 Median:113.50 stddev:3.37 (3.0%) stddev-sans-first:1.50 09:13:56 INFO - PID 4151 | Values: 104.0 112.0 113.0 113.0 113.0 116.0 114.0 114.0 112.0 116.0 09:13:56 INFO - PID 4151 | 09:13:56 INFO - PID 4151 | [#1] audio-beat-detection Cycles:10 Average:134.60 Median:128.00 stddev:17.48 (13.7%) stddev-sans-first:17.36 09:13:56 INFO - PID 4151 | Values: 152.0 124.0 126.0 175.0 130.0 123.0 124.0 122.0 145.0 125.0 09:13:56 INFO - PID 4151 | 09:13:56 INFO - PID 4151 | [#2] audio-dft Cycles:10 Average:165.00 Median:165.00 stddev:2.54 (1.5%) stddev-sans-first:2.67 09:13:56 INFO - PID 4151 | Values: 166.0 164.0 163.0 164.0 169.0 168.0 168.0 163.0 162.0 163.0 09:13:56 INFO - PID 4151 | 09:13:56 INFO - PID 4151 | [#3] audio-fft Cycles:10 Average:79.30 Median:74.50 stddev:10.40 (14.0%) stddev-sans-first:10.92 09:13:56 INFO - PID 4151 | Values: 75.0 74.0 75.0 100.0 74.0 74.0 75.0 74.0 98.0 74.0 09:13:56 INFO - PID 4151 | 09:13:56 INFO - PID 4151 | [#4] audio-oscillator Cycles:10 Average:88.40 Median:83.50 stddev:8.11 (9.7%) stddev-sans-first:8.45 09:13:56 INFO - PID 4151 | Values: 84.0 84.0 101.0 83.0 83.0 83.0 97.0 83.0 84.0 102.0 09:13:56 INFO - PID 4151 | 09:13:56 INFO - PID 4151 | [#5] imaging-gaussian-blur Cycles:10 Average:114.60 Median:115.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 09:13:56 INFO - PID 4151 | Values: 114.0 115.0 114.0 115.0 115.0 115.0 114.0 115.0 115.0 114.0 09:13:56 INFO - PID 4151 | 09:13:56 INFO - PID 4151 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:151.00 stddev:1.20 (0.8%) stddev-sans-first:0.67 09:13:56 INFO - PID 4151 | Values: 154.0 151.0 152.0 151.0 151.0 150.0 151.0 151.0 150.0 150.0 09:13:56 INFO - PID 4151 | 09:13:56 INFO - PID 4151 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 09:13:56 INFO - PID 4151 | Values: 95.0 96.0 95.0 95.0 94.0 95.0 95.0 96.0 94.0 94.0 09:13:56 INFO - PID 4151 | 09:13:56 INFO - PID 4151 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:56.00 stddev:1.62 (2.9%) stddev-sans-first:1.72 09:13:56 INFO - PID 4151 | Values: 56.0 54.0 54.0 56.0 55.0 58.0 55.0 59.0 55.0 56.0 09:13:56 INFO - PID 4151 | 09:13:56 INFO - PID 4151 | [#9] json-stringify-tinderbox Cycles:10 Average:57.80 Median:58.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 09:13:56 INFO - PID 4151 | Values: 58.0 58.0 58.0 58.0 58.0 58.0 58.0 57.0 57.0 58.0 09:13:56 INFO - PID 4151 | 09:13:56 INFO - PID 4151 | [#10] stanford-crypto-aes Cycles:10 Average:91.00 Median:88.00 stddev:8.23 (9.4%) stddev-sans-first:8.70 09:13:56 INFO - PID 4151 | Values: 89.0 86.0 96.0 88.0 86.0 88.0 88.0 89.0 113.0 87.0 09:13:56 INFO - PID 4151 | 09:13:56 INFO - PID 4151 | [#11] stanford-crypto-ccm Cycles:10 Average:139.40 Median:138.50 stddev:4.88 (3.5%) stddev-sans-first:5.17 09:13:56 INFO - PID 4151 | Values: 139.0 136.0 138.0 137.0 135.0 136.0 135.0 145.0 149.0 144.0 09:13:56 INFO - PID 4151 | 09:13:56 INFO - PID 4151 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:198.00 Median:198.50 stddev:5.68 (2.9%) stddev-sans-first:5.43 09:13:56 INFO - PID 4151 | Values: 191.0 192.0 199.0 211.0 202.0 199.0 197.0 194.0 197.0 198.0 09:13:56 INFO - PID 4151 | 09:13:56 INFO - PID 4151 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.20 Median:73.50 stddev:1.03 (1.4%) stddev-sans-first:0.87 09:13:56 INFO - PID 4151 | Values: 75.0 74.0 73.0 73.0 74.0 72.0 72.0 72.0 74.0 73.0 09:13:56 INFO - PID 4151 | -------- Summary: end -------- 09:13:56 INFO - PID 4151 | 09:13:57 INFO - TEST-INFO | 4151: exit 0 09:13:57 INFO - TEST-OK | kraken | took 92059ms 09:13:57 INFO - SUITE-END | took 1240s 09:13:58 INFO - Completed test suite (00:20:40) 09:13:58 INFO - javascript benchmark 09:13:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6708.628195684038, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2706.2422521693925, 2725.1960671601873, 2731.4946734854043, 2755.944881102378, 2757.076379412897, 5105.18317069269, 5225.216217567367, 5246.422893481718, 5257.658252213609, 5311.309529761131, 5194.402643695976, 5208.036513245052, 5216.530512253897, 5302.734863256831, 5315.229291752694, 4621.260598304264, 4653.697509661861, 4663.067386522709, 4690.343351930733, 4709.811607535712, 4524.095180963804, 4637.582617564419, 4661.394018777554, 4671.976640116794, 4725.149473094859, 4557.521460246659, 4637.1421287062, 4649.325847752091, 4704.200285951397, 4752.1921273383605, 4585.931211031804, 4618.468876079261, 4621.907561848778, 4690.249560070372, 4692.788824502905, 4575.245084561044, 4598.4711758147905, 4617.376654151713, 4632.235681112612, 4662.277347011219, 5115.667481613683, 5168.173092305251, 5186.948130518685, 5212.843614691527, 5219.164933610642, 5552.444755524456, 5658.632188907749, 5713.171590119409, 5721.828345149652, 5738.512226460756, 5688.203651488795, 5721.256236689245, 5724.055530837407, 5738.6556806591325, 5756.194132821408, 5270.998510283034, 5285.867853303698, 5287.41838397776, 5291.497307755719, 5366.060939335601, 5638.661680299195, 5698.629589076697, 5707.429257074343, 5766.048601980626, 5815.709214539256, 5583.609147359727, 5621.578381621313, 5622.437756224344, 5622.437756224426, 5639.887202256014, 5653.519450846724, 5679.971600141973, 5686.715664216773, 5687.772489100473, 5692.430756924357, 5525.668459892419, 5549.334079910436, 5656.8868622627315, 5666.065099258659, 5679.034564124109, 5521.613487055867, 5580.637258578179, 5644.322681278273, 5656.123300888369, 5665.801696940587, 4761.666683332202, 4766.880827979328, 4787.569118779257, 4792.496787837296, 4830.372051633335, 3980.5024371953505, 4076.9388459173138, 4087.591240875948, 4117.773522456234, 4127.050778321003, 4749.1926372516755, 4780.402449693788, 4796.0, 4808.2787581863, 4835.782389792468, 5631.155326701028, 5637.746301416446, 5687.232223649754, 5693.231413759089, 5721.342045664718, 4781.8284520292755, 4783.976080119577, 4813.975930120397, 4827.782749776268, 4860.586850117709, 4802.711837289774, 4874.658773885794, 4878.390201224847, 4954.761309672582, 4959.603231741452, 5279.736013199402, 5284.841454756363, 5289.312389389354, 5323.148296272732, 5336.092864213016, 5565.1374037024325, 5634.633748806478, 5682.062459694104, 5685.658860468385, 5688.288963879515, 5240.895182096413, 5253.763580638804, 5255.842324730112, 5340.252364669027, 5353.4646535346155, 5511.476409741068, 5561.443855614568, 5594.804181853616, 5621.100623900156, 5676.631018983753, 5578.6611213309325, 5637.661740295595, 5653.689047102284, 5663.66018038919, 5731.19763233156, 5474.644148130359, 5542.0301447247375, 5551.528120109674, 5583.162525621027, 5592.161175823497, 5521.1442226454965, 5533.114701647717, 5548.334199895877, 5550.38945715979, 5555.0, 5349.919751203813, 5417.133258678593, 5421.972890135524, 5482.418931462316, 5523.309586301712, 5505.229267902577, 5545.223668686306, 5564.165375193753, 5571.359293681278, 5602.551795856403, 5435.483629055233, 5448.645838020516, 5455.18172274162, 5457.181422786613, 5461.0716178248995], "value": 5126.400058805357, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [690.7029977109844, 721.9314165154309, 737.5943231222827, 1053.4153544782648, 1071.6892101290625, 31560.368792624133, 32369.659006263966, 32370.514442283384, 32425.837870810672, 32524.186895327628, 33263.667363326356, 33347.0, 33636.0, 33686.0, 33722.1569460763, 6351.682415879211, 6731.629760363166, 6856.897146542806, 6857.417119544844, 6868.519203655746, 6373.71318290678, 6459.0, 6468.676566171696, 6470.191226096738, 6476.0, 6402.391772781578, 6473.1261279727105, 6474.255460622018, 6478.708458119396, 6489.643069631168, 6417.390347916964, 6441.452476539476, 6478.319776423502, 6478.514111441637, 6491.610503369766, 6464.676766161673, 6470.4823614110755, 6490.707918143695, 6497.837554061139, 6522.510811689142, 29658.55512167319, 29844.70155298441, 29868.8506557468, 29940.850295748598, 30009.849950750107, 2954.2023653613405, 2961.6001839751575, 2964.970350296491, 2975.5834183214365, 2987.507061334877, 23287.883560582257, 23377.76622233773, 23482.178123765585, 23516.0, 23581.88209058961, 2547.1339744486963, 2549.668543089405, 2571.434284457416, 2579.0328626764963, 2581.9483610327875, 141053.0, 142052.28973855064, 142736.0, 146047.0, 151380.0, 37631.0, 37786.244275114346, 37810.62189378126, 37847.243055138744, 37882.81058594689, 39129.41305880414, 39136.21727565433, 39234.0, 39322.72529582037, 39367.40948885769, 12842.165259258118, 12922.030847686461, 12960.222386656831, 12963.935180324039, 12964.675883102998, 10441.060304572626, 10447.268691191544, 10448.791024179625, 10473.109785668152, 10477.528511217013, 12320.199187052813, 12332.0, 12357.567485138157, 12392.194507356993, 12591.622251332476, 5390.164524498709, 5423.0, 5423.755930983115, 5429.131338985743, 5523.613347065667, 863.8013256950936, 911.5487833522317, 920.9723708288763, 923.1507013547553, 944.9669261575812, 19906.203751850055, 20708.068136933874, 20918.372448826558, 21144.471388215417, 21153.25963591298, 995.2286977592279, 995.2684776689127, 998.4907697074399, 999.7950420163849, 1009.3893194617151, 10343.741406464898, 13854.238016909167, 14284.785728214085, 14455.349509272108, 14472.0, 173897.0, 174099.0, 174476.0, 175307.0, 175713.55007724004, 41745.0, 42161.0, 42438.151236975085, 42485.362719559234, 42531.0, 1212.9393530323448, 1260.8739126087319, 1266.1769849597836, 1266.3351740336213, 1267.7464507098432, 22467.43831404228, 23236.3029109127, 24284.63573046441, 24351.14770983007, 24605.38486537851, 28848.2787930295, 28923.7107628921, 28978.27554311159, 29020.12939611815, 29061.7093829059, 152567.0, 153242.0, 153283.23358383583, 153585.0, 154016.22991885417, 27298.81609471198, 27543.724562754116, 27857.72142278551, 29431.85284073566, 29641.0, 35703.82148089243, 35976.280474390886, 35991.64008359988, 36037.81981090078, 36205.81897090498, 25895.741042590085, 26962.19113426522, 26979.730202697723, 27127.0, 27564.724352756217, 26180.095539819755, 26885.462290754465, 27276.863615681796, 27376.863115684293, 28072.43855122927, 30401.69598303989, 30469.847650761603, 30473.23816904595, 30620.540691890084, 30665.0, 26264.21207363782, 26405.60391594166, 26683.0, 27224.455510890068, 27895.72104278931, 21026.47433814167, 22014.33956981293, 22038.779612203674, 22316.66525002094, 22334.88832555827], "value": 14291.951630786425, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.43138742984956, 412.9752214867106, 418.11985769954237, 428.52433798483685, 429.57042957042955, 14297.78553321701, 15196.088234705925, 17134.91432542837, 17770.111494425277, 17799.199036043377, 18089.7286540702, 18548.907255463702, 18619.627607447845, 18759.906200469013, 18950.147243374046, 5252.763625636855, 5393.81121660742, 5518.475744804237, 5523.6409633373705, 5534.197541356501, 4900.166971614816, 5020.573251273646, 5044.319016932722, 5054.848354549351, 5062.190049592066, 4908.092002979461, 4990.026944745776, 5185.144451165572, 5224.164133738603, 5263.842084737464, 5132.871678208037, 5139.460356662571, 5159.974200128994, 5163.3545806774155, 5170.689758614495, 4633.582977532004, 4668.766561671903, 4674.602658774008, 4704.741239231841, 4754.239321708545, 21493.57012859734, 21644.675329870064, 21705.782942170692, 21766.34700958974, 21930.342089737333, 1594.7687585300066, 1616.030381770928, 1617.0701846438344, 1617.9191040447931, 1624.398972380227, 14078.22569758663, 14245.715085698332, 14247.430102795875, 14521.636959076002, 14544.27278636064, 2020.2121172742643, 2049.7130401743766, 2071.5546157576196, 2078.5738923520794, 2082.2191678120703, 81401.9999999994, 85850.99999999937, 88675.0, 90463.0, 92118.53940730254, 10515.26393152472, 10622.0, 10897.29167604119, 10995.230333876552, 11168.553257869757, 15327.31027103783, 15510.922445387701, 15516.689666206612, 15555.766663500057, 15565.533034008999, 7398.96300518494, 7491.66287517063, 7614.771556853303, 7673.271039251262, 7698.461107722517, 6900.206476255295, 7023.416281288956, 7146.428285737128, 7206.963965180141, 7212.891806622905, 6691.089376121403, 6873.965630171817, 6919.204291506541, 6923.515353925177, 6929.237783843773, 2076.958460830775, 2086.2593779208164, 2099.937001889946, 2109.7468303803334, 2229.152921889704, 816.3673153306236, 870.1559487297311, 887.9689210877589, 903.3631289940577, 914.0356923445828, 16690.165491725365, 16797.076160811273, 16914.06972616518, 17194.054327011883, 17575.0, 862.0904945282787, 867.5705525764787, 868.3227082875368, 878.4202426398547, 890.3544929925752, 9187.816243675223, 9188.63245470187, 9472.479013654178, 9529.52352382392, 9575.712728618153, 356075.196240187, 359662.0, 361039.0, 365097.0, 365533.0, 74612.92725481991, 78331.60834195792, 78495.21504784879, 78651.0, 78852.0, 1019.4444028004755, 1027.9074883260541, 1055.2693582524666, 1059.4384975962753, 1060.4644654449453, 14384.568462946128, 14546.781798272823, 14680.55958321252, 14707.67630913223, 15198.924005379902, 37201.4419783698, 38528.614713853625, 38623.42064868973, 38663.58709780689, 39389.0, 47380.0, 48586.27120593123, 48741.268880967524, 49518.257226140915, 49835.75082124566, 7982.920170798217, 8016.9198308016175, 8065.435419520577, 8079.192080792109, 8417.410781245255, 10924.180686448708, 11327.207095503236, 11351.262167959056, 11549.6535103947, 11597.13021523406, 9865.802683946424, 10032.69901902944, 10274.0, 10362.948185259025, 10667.0, 9286.489243091695, 9483.478408687313, 9617.374870633386, 9642.180414664552, 9680.661176858775, 9945.403275803475, 10005.0, 10308.381497110197, 10354.534045968101, 10807.621733239299, 7727.188645192174, 7750.651220695195, 7826.256505631955, 7834.608269586384, 7885.5662938538935, 9748.51257437111, 9911.752206194902, 9958.900410995797, 10099.192064634959, 10123.443210623192], "value": 8559.937429432184, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1209.9455524501398, 1272.1413046193818, 1278.4630455208812, 1281.9038572107095, 1294.1587967820915, 10036.146927511161, 10552.050315471597, 10555.525001374937, 10904.127669786418, 11247.437628118601, 10834.187435942296, 10968.396738179397, 11057.612983545578, 11079.72300692483, 11145.387003714814, 2169.2516081951703, 2183.912643494258, 2208.8785116818567, 2226.065052677871, 2228.19784877444, 2143.0, 2185.4864106934856, 2200.262911924507, 2209.0169874405897, 2214.8671079735186, 2095.8532902696816, 2114.68279758036, 2115.8730476171404, 2122.3632910126976, 2144.4531644430726, 2090.19527481919, 2100.684897265407, 2108.7680355160996, 2109.4409981354875, 2111.039477037944, 1997.5605366819277, 2072.8445366597416, 2076.6054449654516, 2139.4330502416874, 2213.9889300553555, 10495.370277783357, 10652.840207396895, 10655.786884262272, 10657.413842238673, 10723.088537474325, 5603.831885043455, 5845.240118784531, 5856.502197313233, 5867.501262392701, 5873.060310350366, 2994.8502574871386, 3121.812691238533, 3171.349873275996, 3187.059817353886, 3196.680331966808, 937.2221056523069, 939.9389039712465, 1020.4795554267303, 1023.6417253961129, 1050.14937900301, 14830.851691483163, 15172.24138793067, 15197.848021519865, 15294.694106117815, 15368.846311536854, 4877.122118018719, 4965.354503914468, 4971.328870602422, 4988.700677959334, 4992.0, 12028.759424811455, 12073.818892716616, 12077.15459917815, 12090.697732556757, 12122.878771212352, 5537.889242215214, 5720.11338242573, 5748.913766293509, 5753.280839895013, 5764.077747560454, 5042.571381432619, 5049.267856160836, 5072.873178170502, 5109.38687357512, 5111.8722031948755, 4154.539690780804, 4224.1129362833535, 4226.619604235633, 4288.078063216423, 4317.935230971538, 1342.2483409290828, 1402.382951501336, 1405.9648508787157, 1422.7012327411153, 1424.7934049562755, 656.3797211634959, 676.2493632068498, 680.73451353972, 700.8913618389158, 706.1349846438175, 5497.835064948058, 5556.805511807067, 5708.65748055118, 5735.139729040678, 5787.160861675034, 553.6318348298337, 574.4083593898291, 576.3314555116045, 577.982660520185, 580.5761793890483, 4036.979815100906, 4037.959620403817, 4069.959300407017, 4102.446169767103, 4459.375687403766, 13510.189388636516, 13656.112352697042, 14297.928510357382, 14332.49836255747, 14354.856451435351, 13376.331183440789, 13595.728085438235, 13665.111767735065, 13826.446942122202, 13895.166290022631, 7187.209406965125, 7219.963900180465, 7408.3332500074175, 7411.66647500853, 7429.44279179053, 6437.420632143129, 6597.175353080865, 6646.235682896336, 6745.898811517733, 6918.201267670342, 12374.566890158801, 12455.439505222106, 12684.429200685807, 12685.365731713562, 12767.361631918553, 12587.74824503523, 12847.421866016239, 12857.67855803575, 12897.290649014394, 13008.739825203633, 8143.144969778088, 8385.874211886949, 8399.790005249673, 8424.452410593292, 8436.24073833358, 9333.0, 9445.433274003582, 9535.09416605449, 9575.138237558653, 9589.232861371212, 8198.59007049657, 8266.13205613426, 8304.958475207586, 8338.37462190326, 8352.624131913957, 8162.877556836534, 8215.671373145007, 8225.383096267684, 8310.667573297, 8410.327173825957, 7526.02161718973, 7563.9621801890635, 7601.619919004138, 7604.391648668204, 7652.579108149105, 5122.513361230677, 5184.300119483822, 5260.658057226268, 5284.26020357158, 5483.890322193613, 5081.796728130834, 5089.134847075932, 5157.690538567698, 5235.874287028307, 5387.0], "value": 4793.671356356546, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.08418895266215, 354.8651512425278, 358.42293906810033, 362.9473726309685, 366.11400411005354, 5404.729763511818, 5498.862528436786, 5502.147167189087, 5522.751476183571, 5531.502164805167, 5325.840224793263, 5401.972990135044, 5406.83779486615, 5416.891662166764, 5419.756110975006, 4066.857659981894, 4076.2458945095104, 4082.6733861291027, 4090.7954602269915, 4091.672666186698, 3946.4080387941895, 4060.8984775380554, 4087.2847251730827, 4095.365218391154, 4115.773632450214, 4045.271851066807, 4050.129222217223, 4050.979745101285, 4065.8373665053364, 4074.0, 3993.420953961688, 4019.075612609102, 4019.718619696622, 4032.0, 4048.5951404859425, 3509.613223239586, 3521.8730006397964, 3531.6644918732677, 3535.1338921964025, 3537.0449978505917, 5251.4485978972425, 5275.947240527584, 5346.545543628797, 5355.812546560891, 5360.705161216131, 4793.5925446337105, 4810.470848206694, 4835.492273311322, 4843.515648435164, 4865.586425153866, 5628.493435590816, 5768.192453056576, 5785.190073389729, 5785.768569257225, 5800.7679692812235, 3962.841486340543, 3987.7208595398333, 3988.581198974095, 3994.660453861425, 4006.4991876015497, 5869.295684517842, 6125.111858780452, 6134.662593557353, 6139.723712432907, 6183.1961844960315, 3965.365541513344, 3967.781772002568, 3968.464257325224, 3971.907725375545, 3973.8609148679657, 3985.5416627087675, 3989.5212574491247, 3990.38149086892, 4000.599940006034, 4010.2781499329817, 4565.76724284448, 4696.412948381452, 4704.647151463654, 4708.929366059512, 4710.940038491312, 5805.796797112081, 5806.593538452268, 5837.357890632027, 5846.766129354778, 5865.67738774363, 1405.3697710655795, 1416.5113036002563, 1418.198717724503, 1419.921904295253, 1420.9147451152758, 898.5507246376811, 942.0861764088822, 949.4825320200507, 953.3374304858196, 958.736347504428, 4998.175301075355, 5001.349824522788, 5043.142665746758, 5047.570956468741, 5092.465291144376, 5940.34656187819, 5953.940460595425, 5969.164316995624, 6034.818955431344, 6044.637321760709, 4874.610031197496, 4995.650304478651, 4998.650094493423, 5017.3226614406585, 5048.974755126201, 3150.6061742282213, 3175.9364812703616, 3190.8512935343256, 3191.4734068878374, 3192.0, 5439.918401223985, 5535.474129957647, 5537.529310008614, 5552.972700050504, 5583.525400341016, 6004.729787159588, 6091.695415229221, 6134.478569321568, 6167.506599472032, 6174.845628859314, 5540.168974653834, 5551.583631227593, 5564.888702225933, 5565.777368905198, 5582.330120385498, 5772.393898640582, 5926.644401335933, 5945.940540594539, 5986.2517185351835, 6012.368701286477, 5891.734871930859, 5924.6149000314845, 5930.043085781595, 5933.970330148494, 5939.891338574744, 5355.491228333302, 5569.10894256917, 5594.915711530687, 5594.944050559442, 5600.467955544217, 4034.91930161401, 4050.7569545827346, 4055.330870406468, 4060.451839001815, 4063.7764922929523, 5897.64614123154, 6015.488683461955, 6047.395260473917, 6057.1519987200945, 6079.726412311368, 5815.476607105212, 5839.948809214382, 5852.449100988327, 5854.121881717776, 5878.882422351615, 5746.3966283541295, 5803.448672376117, 5812.82561523155, 5825.3592104867585, 5844.211031510692, 5512.503874651301, 5734.426557344233, 5753.389051065708, 5766.135079738073, 5766.509846663081, 5851.824445266649, 5900.7049647518315, 5903.0, 5916.881662366643, 5919.6152250103605, 5466.781328746805, 5683.658980461186, 5713.600047996601, 5713.628614140068, 5738.196652468574], "value": 4288.280807615366, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [745.9813504662385, 759.7264984605541, 761.7219714804098, 766.455816370377, 772.4708574626378, 13299.401526931288, 13626.727465450698, 13724.24516651585, 14892.180930048842, 16197.595060123473, 15224.010439321464, 15384.076955382685, 15384.692306153898, 15440.768388474155, 15447.073175609472, 902.4585248850686, 919.7700574856286, 921.870938068671, 922.7416323429451, 927.3554879358849, 918.1782304837167, 921.5991043895926, 923.6351641101761, 925.6066171876926, 925.8240934222509, 904.1681652879333, 944.9007854175316, 954.766082309835, 965.2133511188395, 972.2562239886457, 934.3226161033265, 937.4562753602894, 941.9058094190594, 944.0748066894413, 945.5461378538306, 687.8693048320853, 690.5614934516568, 692.0380670867498, 692.6225207262054, 692.7679227458807, 13794.517191898336, 13885.097468664504, 13931.164130152121, 14015.229162396065, 14051.71896562063, 15086.321115549827, 15959.281832317574, 15962.441314554051, 15999.360025598962, 16098.83901160985, 12302.138850280484, 12385.504579816796, 12406.007519398518, 12444.502219911192, 12461.688457788538, 3008.2629755709772, 3033.620797400325, 3039.1794215561895, 3046.7562594992346, 3055.663876973531, 82656.58671706663, 84137.57931210365, 84549.57725211335, 84824.0, 85521.57239213763, 12106.576269830513, 12173.756524869454, 12371.412290435674, 12380.690482737824, 12493.750124997448, 23716.64425033626, 24738.0, 24789.5042099157, 24933.62599561008, 24979.125730599342, 6028.517718582503, 6041.24484439445, 6053.727582258809, 6074.481379655086, 6112.938870611237, 2733.5079685656774, 2828.3918957424253, 2834.858257087137, 2848.928776780597, 2853.0727513558177, 3445.8621655134016, 3548.733844961638, 3548.7515873889097, 3571.339302229096, 3575.856965721342, 595.8778450417655, 599.7031469422576, 604.4439116013278, 607.3076692570473, 607.5534482155612, 564.6527385657873, 587.4037851580649, 588.5909293041295, 588.9469947704728, 593.104412337365, 9145.405548639317, 9578.521073946275, 9843.606255749834, 10340.793184136275, 10537.104346130665, 541.1666034307201, 550.7411516587198, 560.3080195957989, 562.3476766950319, 580.089259862021, 4418.425604671372, 4546.840860569864, 4562.178807814559, 4598.747068911175, 4698.906021879543, 89463.71546084729, 89845.0, 90165.54917225504, 90473.0, 92208.53895730613, 79755.0, 79978.0, 80452.0, 81454.18545814585, 81846.59076704578, 58882.0, 61323.0, 62851.0, 63061.0, 66597.66701166463, 9967.50162491887, 10555.577776889146, 10578.910063791003, 11196.160287978271, 11336.546538138382, 27537.0, 27642.308942276602, 28208.576871347355, 28829.99095031664, 29142.854285728437, 35032.82483587566, 35387.82306088556, 35663.82168089247, 35929.46105808467, 36300.81849590735, 13073.15024523403, 13249.536266230636, 13323.067385282937, 13479.056466047283, 13587.116837405538, 15901.125438101015, 15981.600459988593, 16057.518274451319, 16062.598435039217, 16250.918745406198, 13509.59471215865, 13716.245606491739, 13782.0, 13839.0, 13973.441062357391, 13746.381412836246, 13818.516351927634, 14326.641833954234, 14348.354324055652, 14551.126932384092, 14219.857801422268, 14521.0, 14592.416303347747, 14658.486952956595, 15164.24178791034, 10082.193424525874, 10473.842892356774, 10504.947475262576, 10529.526171322155, 10569.207309451667, 10582.259241852997, 11483.311001339946, 12482.75034499323, 12504.124711270124, 12679.80980285278], "value": 7070.425260940725, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1555.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 113.0, 113.0, 113.0, 116.0, 114.0, 114.0, 112.0, 116.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 124.0, 126.0, 175.0, 130.0, 123.0, 124.0, 122.0, 145.0, 125.0], "value": 134.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 163.0, 164.0, 169.0, 168.0, 168.0, 163.0, 162.0, 163.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 100.0, 74.0, 74.0, 75.0, 74.0, 98.0, 74.0], "value": 79.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 101.0, 83.0, 83.0, 83.0, 97.0, 83.0, 84.0, 102.0], "value": 88.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 115.0, 115.0, 115.0, 114.0, 115.0, 115.0, 114.0], "value": 114.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 151.0, 152.0, 151.0, 151.0, 150.0, 151.0, 151.0, 150.0, 150.0], "value": 151.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 94.0, 95.0, 95.0, 96.0, 94.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 54.0, 56.0, 55.0, 58.0, 55.0, 59.0, 55.0, 56.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 58.0, 58.0, 58.0, 58.0, 58.0, 57.0, 57.0, 58.0], "value": 57.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 96.0, 88.0, 86.0, 88.0, 88.0, 89.0, 113.0, 87.0], "value": 91.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 136.0, 138.0, 137.0, 135.0, 136.0, 135.0, 145.0, 149.0, 144.0], "value": 139.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [191.0, 192.0, 199.0, 211.0, 202.0, 199.0, 197.0, 194.0, 197.0, 198.0], "value": 198.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 73.0, 73.0, 74.0, 72.0, 72.0, 72.0, 74.0, 73.0], "value": 73.2, "unit": "score"}]}]} 09:13:58 INFO - Return code: 0 09:13:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:13:58 INFO - # TBPL SUCCESS # 09:13:58 INFO - Running post-action listener: _resource_record_post_action 09:13:58 INFO - [mozharness: 2017-05-25 16:13:58.213644Z] Finished run-tests step (success) 09:13:58 INFO - Running post-run listener: _resource_record_post_run 09:13:58 INFO - Total resource usage - Wall time: 1256s; CPU: 13.0%; Read bytes: 8531968; Write bytes: 413241344; Read time: 1776; Write time: 404196 09:13:58 INFO - TinderboxPrint: CPU usage
12.7% 09:13:58 INFO - TinderboxPrint: I/O read bytes / time
8,531,968 / 1,776 09:13:58 INFO - TinderboxPrint: I/O write bytes / time
413,241,344 / 404,196 09:13:58 INFO - TinderboxPrint: CPU idle
8,744.6 (87.3%) 09:13:58 INFO - TinderboxPrint: CPU user
1,216.9 (12.1%) 09:13:58 INFO - TinderboxPrint: Swap in / out
0 / 0 09:13:58 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 65536; Write bytes: 109314048; Read time: 268; Write time: 124812 09:13:58 INFO - run-tests - Wall time: 1241s; CPU: 13.0%; Read bytes: 6721536; Write bytes: 303927296; Read time: 1476; Write time: 279384 09:13:58 INFO - Running post-run listener: _upload_blobber_files 09:13:58 INFO - Blob upload gear active. 09:13:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:13:58 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 09:13:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:13:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:13:59 INFO - (blobuploader) - INFO - Open directory for files ... 09:13:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:13:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:13:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:14:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:14:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:14:00 INFO - (blobuploader) - INFO - Done attempting. 09:14:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:14:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:14:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:14:00 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:14:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:14:00 INFO - (blobuploader) - INFO - Done attempting. 09:14:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:14:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:14:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:14:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:14:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:14:01 INFO - (blobuploader) - INFO - Done attempting. 09:14:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:14:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:14:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:14:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:14:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:14:07 INFO - (blobuploader) - INFO - Done attempting. 09:14:07 INFO - (blobuploader) - INFO - Iteration through files over. 09:14:07 INFO - Return code: 0 09:14:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:14:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:14:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c2c7a443a898e5691c81c8f91b95a9983f7206df3fea7e8bb678f0b796fdca763a2807532bc058ddda31d331ac8d010e625745788d98d7bfa4b9a887bf705213", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5523589115d42952b22d839f5395fce65a8d126b1dcd04a68950d5cd004f8ba96de6b6e077d60a0a11d29248831fbf28efa57d8b20a280d7e01eacacec4d446e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2ec5705ee6c9f5f9b919513710bf258f5030ad72fab2f01a12b2e468c00473b46751e9de6c7920f9901f904e181470ffc8284681dcec5428a7bafe2d0ce52f5f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/43ecb647848609b916d44fd448b76ac6b148203a1c33bb77969e73832b99f321a04239f39aabfbf9839d0128186a124ec301e8ce5a1f447b470a5dae7032bce0"} 09:14:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:14:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:14:07 INFO - Contents: 09:14:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c2c7a443a898e5691c81c8f91b95a9983f7206df3fea7e8bb678f0b796fdca763a2807532bc058ddda31d331ac8d010e625745788d98d7bfa4b9a887bf705213", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5523589115d42952b22d839f5395fce65a8d126b1dcd04a68950d5cd004f8ba96de6b6e077d60a0a11d29248831fbf28efa57d8b20a280d7e01eacacec4d446e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2ec5705ee6c9f5f9b919513710bf258f5030ad72fab2f01a12b2e468c00473b46751e9de6c7920f9901f904e181470ffc8284681dcec5428a7bafe2d0ce52f5f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/43ecb647848609b916d44fd448b76ac6b148203a1c33bb77969e73832b99f321a04239f39aabfbf9839d0128186a124ec301e8ce5a1f447b470a5dae7032bce0"} 09:14:07 INFO - Running post-run listener: copy_logs_to_upload_dir 09:14:07 INFO - Copying logs to upload dir... 09:14:07 INFO - mkdir: /builds/slave/test/build/upload/logs 09:14:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1318.744815 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 58 secs) (at 2017-05-25 09:14:07.604482) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-25 09:14:07.609626) ========= 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=c6927cf182745ad25b1d38b9000001fe-1495720935.175755-1451179319 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-Non-PGO/sha512/c2c7a443a898e5691c81c8f91b95a9983f7206df3fea7e8bb678f0b796fdca763a2807532bc058ddda31d331ac8d010e625745788d98d7bfa4b9a887bf705213", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5523589115d42952b22d839f5395fce65a8d126b1dcd04a68950d5cd004f8ba96de6b6e077d60a0a11d29248831fbf28efa57d8b20a280d7e01eacacec4d446e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2ec5705ee6c9f5f9b919513710bf258f5030ad72fab2f01a12b2e468c00473b46751e9de6c7920f9901f904e181470ffc8284681dcec5428a7bafe2d0ce52f5f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/43ecb647848609b916d44fd448b76ac6b148203a1c33bb77969e73832b99f321a04239f39aabfbf9839d0128186a124ec301e8ce5a1f447b470a5dae7032bce0"} build_url:https://queue.taskcluster.net/v1/task/Qr857TJ7Qg2wIq7dexMhkw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011212 build_url: 'https://queue.taskcluster.net/v1/task/Qr857TJ7Qg2wIq7dexMhkw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c2c7a443a898e5691c81c8f91b95a9983f7206df3fea7e8bb678f0b796fdca763a2807532bc058ddda31d331ac8d010e625745788d98d7bfa4b9a887bf705213", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5523589115d42952b22d839f5395fce65a8d126b1dcd04a68950d5cd004f8ba96de6b6e077d60a0a11d29248831fbf28efa57d8b20a280d7e01eacacec4d446e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2ec5705ee6c9f5f9b919513710bf258f5030ad72fab2f01a12b2e468c00473b46751e9de6c7920f9901f904e181470ffc8284681dcec5428a7bafe2d0ce52f5f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/43ecb647848609b916d44fd448b76ac6b148203a1c33bb77969e73832b99f321a04239f39aabfbf9839d0128186a124ec301e8ce5a1f447b470a5dae7032bce0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-25 09:14:07.641378) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 09:14:07.641796) ========= 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=c6927cf182745ad25b1d38b9000001fe-1495720935.175755-1451179319 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004472 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 09:14:07.724523) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-25 09:14:07.724893) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-25 09:14:07.725258) ========= ========= Total master_lag: 0.22 =========