builder: mozilla-beta_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-043 starttime: 1496173166.93 results: success (0) revision: b6b58f56432af99bc6b8356da3ea96170a04190e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-30 12:39:26.932088) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-30 12:39:26.932470) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-30 12:39:26.932734) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-30 12:39:26.990396) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 12:39:26.990671) ========= 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=d2a8c569965ab8367867b893000001a1-1496171467.168564-1124926776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-30 12:39:27-- 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% 46.2M=0s 2017-05-30 12:39:27 (46.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.099344 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 12:39:27.120273) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 12:39:27.120622) ========= 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=d2a8c569965ab8367867b893000001a1-1496171467.168564-1124926776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018639 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 12:39:27.176909) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-30 12:39:27.177284) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b6b58f56432af99bc6b8356da3ea96170a04190e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b6b58f56432af99bc6b8356da3ea96170a04190e --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=d2a8c569965ab8367867b893000001a1-1496171467.168564-1124926776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-30 12:39:27,351 truncating revision to first 12 chars 2017-05-30 12:39:27,351 Setting DEBUG logging. 2017-05-30 12:39:27,351 attempt 1/10 2017-05-30 12:39:27,351 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/b6b58f56432a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-30 12:39:28,116 unpacking tar archive at: mozilla-beta-b6b58f56432a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.134749 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-30 12:39:28.325846) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-30 12:39:28.326156) ========= script_repo_revision: b6b58f56432af99bc6b8356da3ea96170a04190e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-30 12:39:28.326529) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-30 12:39:28.326798) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-30 12:39:28.336703) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-05-30 12:39:28.337066) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-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', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-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=d2a8c569965ab8367867b893000001a1-1496171467.168564-1124926776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:39:28 INFO - MultiFileLogger online at 20170530 12:39:28 in /builds/slave/test 12:39:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 12:39:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:39:28 INFO - {'append_to_log': False, 12:39:28 INFO - 'base_work_dir': '/builds/slave/test', 12:39:28 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 12:39:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:39:28 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 12:39:28 INFO - 'buildbot_json_path': 'buildprops.json', 12:39:28 INFO - 'config_files': ('talos/linux_config.py',), 12:39:28 INFO - 'default_actions': ('clobber', 12:39:28 INFO - 'read-buildbot-config', 12:39:28 INFO - 'download-and-extract', 12:39:28 INFO - 'populate-webroot', 12:39:28 INFO - 'create-virtualenv', 12:39:28 INFO - 'install', 12:39:28 INFO - 'run-tests'), 12:39:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:39:28 INFO - 'download_minidump_stackwalk': True, 12:39:28 INFO - 'download_symbols': 'ondemand', 12:39:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:39:28 INFO - 'tooltool.py': '/tools/tooltool.py', 12:39:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:39:28 INFO - '/tools/misc-python/virtualenv.py')}, 12:39:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:39:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:39:28 INFO - 'gecko_profile': False, 12:39:28 INFO - 'gecko_profile_interval': 0, 12:39:28 INFO - 'installer_path': 'installer.exe', 12:39:28 INFO - 'log_level': 'info', 12:39:28 INFO - 'log_name': 'talos', 12:39:28 INFO - 'log_to_console': True, 12:39:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:39:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:39:28 INFO - 'opt_config_files': (), 12:39:28 INFO - 'pip_index': False, 12:39:28 INFO - 'suite': 'dromaeojs', 12:39:28 INFO - 'system_bits': '32', 12:39:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:39:28 INFO - 'title': 'talos-linux64-ix-043', 12:39:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:39:28 INFO - 'use_talos_json': True, 12:39:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:39:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:39:28 INFO - 'work_dir': 'build'} 12:39:28 INFO - [mozharness: 2017-05-30 19:39:28.605721Z] Running clobber step. 12:39:28 INFO - Running pre-action listener: _resource_record_pre_action 12:39:28 INFO - Running main action method: clobber 12:39:28 INFO - rmtree: /builds/slave/test/build 12:39:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:39:29 INFO - Running post-action listener: _resource_record_post_action 12:39:29 INFO - [mozharness: 2017-05-30 19:39:29.637570Z] Finished clobber step (success) 12:39:29 INFO - [mozharness: 2017-05-30 19:39:29.637672Z] Running read-buildbot-config step. 12:39:29 INFO - Running pre-action listener: _resource_record_pre_action 12:39:29 INFO - Running main action method: read_buildbot_config 12:39:29 INFO - Using buildbot properties: 12:39:29 INFO - { 12:39:29 INFO - "project": "", 12:39:29 INFO - "product": "firefox", 12:39:29 INFO - "who": "ryanvm@gmail.com", 12:39:29 INFO - "installer_path": "public/build/target.tar.bz2", 12:39:29 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 12:39:29 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta/", 12:39:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs", 12:39:29 INFO - "stage_platform": "linux64", 12:39:29 INFO - "basedir": "/builds/slave/test", 12:39:29 INFO - "buildnumber": 65, 12:39:29 INFO - "platform": "ubuntu64_hw", 12:39:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:39:29 INFO - "slavebuilddir": "test", 12:39:29 INFO - "taskId": "YcvvpKi-TkCLTD-miMV55w", 12:39:29 INFO - "branch": "mozilla-beta", 12:39:29 INFO - "script_repo_revision": "production", 12:39:29 INFO - "revision": "b6b58f56432af99bc6b8356da3ea96170a04190e", 12:39:29 INFO - "slavename": "talos-linux64-ix-043", 12:39:29 INFO - "repo_path": "releases/mozilla-beta" 12:39:29 INFO - } 12:39:29 INFO - Finding installer, test and symbols from parent task. 12:39:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YcvvpKi-TkCLTD-miMV55w'}, attempt #1 12:39:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YcvvpKi-TkCLTD-miMV55w'}, attempt #1 12:39:30 INFO - Task dependencies: GwP3vRZZRVuz-R5itW5BeQ 12:39:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GwP3vRZZRVuz-R5itW5BeQ'}, attempt #1 12:39:31 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/GwP3vRZZRVuz-R5itW5BeQ/artifacts/public/build/target.tar.bz2 12:39:31 INFO - Set test_url: https://queue.taskcluster.net/v1/task/GwP3vRZZRVuz-R5itW5BeQ/artifacts/public/build/test_packages.json 12:39:31 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/GwP3vRZZRVuz-R5itW5BeQ/artifacts/public/build/target.crashreporter-symbols.zip 12:39:31 INFO - Running post-action listener: _resource_record_post_action 12:39:31 INFO - [mozharness: 2017-05-30 19:39:31.021093Z] Finished read-buildbot-config step (success) 12:39:31 INFO - [mozharness: 2017-05-30 19:39:31.021310Z] Running download-and-extract step. 12:39:31 INFO - Running pre-action listener: _resource_record_pre_action 12:39:31 INFO - Running main action method: download_and_extract 12:39:31 INFO - mkdir: /builds/slave/test/build/tests 12:39:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:39:31 INFO - trying https://queue.taskcluster.net/v1/task/GwP3vRZZRVuz-R5itW5BeQ/artifacts/public/build/target.test_packages.json 12:39:31 INFO - Downloading https://queue.taskcluster.net/v1/task/GwP3vRZZRVuz-R5itW5BeQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 12:39:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GwP3vRZZRVuz-R5itW5BeQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 12:39:31 INFO - Downloaded 986 bytes. 12:39:31 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 12:39:31 INFO - Using the following test package requirements: 12:39:31 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 12:39:31 INFO - u'common': [u'target.common.tests.zip'], 12:39:31 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 12:39:31 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 12:39:31 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 12:39:31 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 12:39:31 INFO - u'mozbase': [u'target.common.tests.zip'], 12:39:31 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 12:39:31 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 12:39:31 INFO - u'web-platform': [u'target.common.tests.zip', 12:39:31 INFO - u'target.web-platform.tests.zip'], 12:39:31 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 12:39:31 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 12:39:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GwP3vRZZRVuz-R5itW5BeQ/artifacts/public/build/target.common.tests.zip 12:39:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GwP3vRZZRVuz-R5itW5BeQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:39:31 INFO - Fetch https://queue.taskcluster.net/v1/task/GwP3vRZZRVuz-R5itW5BeQ/artifacts/public/build/target.common.tests.zip into memory 12:39:34 INFO - Expected file size: 59710971 12:39:34 INFO - Obtained file size: 59710971 12:39:44 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 12:39:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GwP3vRZZRVuz-R5itW5BeQ/artifacts/public/build/target.common.tests.zip 12:39:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GwP3vRZZRVuz-R5itW5BeQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:39:44 INFO - Fetch https://queue.taskcluster.net/v1/task/GwP3vRZZRVuz-R5itW5BeQ/artifacts/public/build/target.common.tests.zip into memory 12:39:46 INFO - Expected file size: 59710971 12:39:46 INFO - Obtained file size: 59710971 12:39:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GwP3vRZZRVuz-R5itW5BeQ/artifacts/public/build/target.talos.tests.zip 12:39:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GwP3vRZZRVuz-R5itW5BeQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 12:39:56 INFO - Fetch https://queue.taskcluster.net/v1/task/GwP3vRZZRVuz-R5itW5BeQ/artifacts/public/build/target.talos.tests.zip into memory 12:39:57 INFO - Expected file size: 14404461 12:39:57 INFO - Obtained file size: 14404461 12:39:57 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')]} 12:39:57 INFO - trying https://queue.taskcluster.net/v1/task/GwP3vRZZRVuz-R5itW5BeQ/artifacts/public/build/target.tar.bz2 12:39:57 INFO - Downloading https://queue.taskcluster.net/v1/task/GwP3vRZZRVuz-R5itW5BeQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 12:39:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GwP3vRZZRVuz-R5itW5BeQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 12:40:00 INFO - Downloaded 59816688 bytes. 12:40:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GwP3vRZZRVuz-R5itW5BeQ/artifacts/public/build/target.tar.bz2 12:40:00 INFO - mkdir: /builds/slave/test/properties 12:40:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:40:00 INFO - Writing to file /builds/slave/test/properties/build_url 12:40:00 INFO - Contents: 12:40:00 INFO - build_url:https://queue.taskcluster.net/v1/task/GwP3vRZZRVuz-R5itW5BeQ/artifacts/public/build/target.tar.bz2 12:40:00 INFO - Running post-action listener: _resource_record_post_action 12:40:00 INFO - Running post-action listener: set_extra_try_arguments 12:40:00 INFO - [mozharness: 2017-05-30 19:40:00.093214Z] Finished download-and-extract step (success) 12:40:00 INFO - [mozharness: 2017-05-30 19:40:00.093439Z] Running populate-webroot step. 12:40:00 INFO - Running pre-action listener: _resource_record_pre_action 12:40:00 INFO - Running main action method: populate_webroot 12:40:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:40:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:40:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:40:00 INFO - '--tppagecycles', 12:40:00 INFO - '7'], 12:40:00 INFO - 'tests': ['tsvgm']}}, 12:40:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:40:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:40:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:40:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:40:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:40:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:40:00 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:40:00 INFO - 'talos_options': ['--disable-e10s'], 12:40:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:40:00 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:40:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:40:00 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:40:00 INFO - 'talos_options': ['--disable-e10s'], 12:40:00 INFO - 'tests': ['damp', 'tps']}, 12:40:00 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:40:00 INFO - 'tests': ['damp', 'tps']}, 12:40:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:40:00 INFO - 'tests': ['dromaeo_dom']}, 12:40:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:40:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:40:00 INFO - 'tests': ['basic_compositor_video']}, 12:40:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:40:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:40:00 INFO - 'tests': ['a11yr', 12:40:00 INFO - 'ts_paint', 12:40:00 INFO - 'tpaint', 12:40:00 INFO - 'sessionrestore', 12:40:00 INFO - 'sessionrestore_no_auto_restore', 12:40:00 INFO - 'tabpaint']}, 12:40:00 INFO - 'other-e10s': {'tests': ['a11yr', 12:40:00 INFO - 'ts_paint', 12:40:00 INFO - 'tpaint', 12:40:00 INFO - 'sessionrestore', 12:40:00 INFO - 'sessionrestore_no_auto_restore', 12:40:00 INFO - 'tabpaint']}, 12:40:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:40:00 INFO - 'ts_paint', 12:40:00 INFO - 'tpaint', 12:40:00 INFO - 'sessionrestore', 12:40:00 INFO - 'sessionrestore_no_auto_restore', 12:40:00 INFO - 'tabpaint']}, 12:40:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:40:00 INFO - 'ts_paint', 12:40:00 INFO - 'tpaint', 12:40:00 INFO - 'sessionrestore', 12:40:00 INFO - 'sessionrestore_no_auto_restore', 12:40:00 INFO - 'tabpaint']}, 12:40:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:40:00 INFO - 'tests': ['a11yr', 12:40:00 INFO - 'ts_paint', 12:40:00 INFO - 'tpaint', 12:40:00 INFO - 'sessionrestore', 12:40:00 INFO - 'sessionrestore_no_auto_restore', 12:40:00 INFO - 'tabpaint']}, 12:40:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:40:00 INFO - 'tests': ['a11yr', 12:40:00 INFO - 'ts_paint', 12:40:00 INFO - 'tpaint', 12:40:00 INFO - 'sessionrestore', 12:40:00 INFO - 'sessionrestore_no_auto_restore', 12:40:00 INFO - 'tabpaint']}, 12:40:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:40:00 INFO - 'tests': ['tsvgx', 12:40:00 INFO - 'tsvgr_opacity', 12:40:00 INFO - 'tart', 12:40:00 INFO - 'tscrollx', 12:40:00 INFO - 'cart', 12:40:00 INFO - 'tsvg_static']}, 12:40:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:40:00 INFO - 'tsvgr_opacity', 12:40:00 INFO - 'tart', 12:40:00 INFO - 'tscrollx', 12:40:00 INFO - 'cart', 12:40:00 INFO - 'tsvg_static']}, 12:40:00 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:40:00 INFO - 'talos_options': ['--disable-e10s'], 12:40:00 INFO - 'tests': ['tp5o']}, 12:40:00 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:40:00 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:40:00 INFO - 'talos_options': ['--disable-e10s', 12:40:00 INFO - '--xperf_path', 12:40:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:40:00 INFO - 'tests': ['tp5n']}, 12:40:00 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:40:00 INFO - 'talos_options': ['--xperf_path', 12:40:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:40:00 INFO - 'tests': ['tp5n']}}, 12:40:00 INFO - 'talos.zip': {'path': '', 12:40:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:40:00 INFO - Running post-action listener: _resource_record_post_action 12:40:00 INFO - [mozharness: 2017-05-30 19:40:00.111575Z] Finished populate-webroot step (success) 12:40:00 INFO - [mozharness: 2017-05-30 19:40:00.111665Z] Running create-virtualenv step. 12:40:00 INFO - Running pre-action listener: _resource_record_pre_action 12:40:00 INFO - Running main action method: create_virtualenv 12:40:00 INFO - Creating virtualenv /builds/slave/test/build/venv 12:40:00 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 12:40:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:40:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:40:00 INFO - Using real prefix '/usr' 12:40:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:40:00 INFO - Installing distribute.............................................................................................................................................................................................done. 12:40:02 INFO - Installing pip.................done. 12:40:02 INFO - Return code: 0 12:40:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:40:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:40:02 INFO - Reading from file tmpfile_stdout 12:40:02 INFO - Output received: 12:40:02 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) 12:40:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:40:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd71a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfce400>, '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 0xfcf3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcf840>, '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': 'd2a8c569965ab8367867b893000001a1-1496171467.168564-1124926776', '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 12:40:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:40:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:40:02 INFO - Using env: {'DISPLAY': ':0', 12:40:02 INFO - 'HOME': '/home/cltbld', 12:40:02 INFO - 'LANG': 'en_US.UTF-8', 12:40:02 INFO - 'LANGUAGE': 'en_US:en', 12:40:02 INFO - 'LOGNAME': 'cltbld', 12:40:02 INFO - 'MAIL': '/var/mail/cltbld', 12:40:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:02 INFO - 'MOZ_NO_REMOTE': '1', 12:40:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:02 INFO - 'NO_EM_RESTART': '1', 12:40:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:02 INFO - 'PWD': '/builds/slave/test', 12:40:02 INFO - 'SHELL': '/bin/bash', 12:40:02 INFO - 'SHLVL': '1', 12:40:02 INFO - 'TERM': 'linux', 12:40:02 INFO - 'TMOUT': '86400', 12:40:02 INFO - 'USER': 'cltbld', 12:40:02 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1496171467.168564-1124926776', 12:40:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:02 INFO - '_': '/tools/buildbot/bin/python'} 12:40:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:03 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 12:40:03 INFO - Cleaning up... 12:40:03 INFO - Return code: 0 12:40:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:40:03 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')]} 12:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:03 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')]} 12:40:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:03 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 0xd331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd71a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfce400>, '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 0xfcf3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcf840>, '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': 'd2a8c569965ab8367867b893000001a1-1496171467.168564-1124926776', '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 12:40:03 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 12:40:03 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 12:40:03 INFO - Using env: {'DISPLAY': ':0', 12:40:03 INFO - 'HOME': '/home/cltbld', 12:40:03 INFO - 'LANG': 'en_US.UTF-8', 12:40:03 INFO - 'LANGUAGE': 'en_US:en', 12:40:03 INFO - 'LOGNAME': 'cltbld', 12:40:03 INFO - 'MAIL': '/var/mail/cltbld', 12:40:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:03 INFO - 'MOZ_NO_REMOTE': '1', 12:40:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:03 INFO - 'NO_EM_RESTART': '1', 12:40:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:03 INFO - 'PWD': '/builds/slave/test', 12:40:03 INFO - 'SHELL': '/bin/bash', 12:40:03 INFO - 'SHLVL': '1', 12:40:03 INFO - 'TERM': 'linux', 12:40:03 INFO - 'TMOUT': '86400', 12:40:03 INFO - 'USER': 'cltbld', 12:40:03 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1496171467.168564-1124926776', 12:40:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:03 INFO - '_': '/tools/buildbot/bin/python'} 12:40:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:03 INFO - Downloading/unpacking psutil>=3.1.1 12:40:03 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 12:40:03 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 12:40:03 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 12:40:03 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 12:40:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:40:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:40:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:40:04 INFO - Installing collected packages: psutil 12:40:04 INFO - Running setup.py install for psutil 12:40:04 INFO - building 'psutil._psutil_linux' extension 12:40:04 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 12:40:04 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 12:40:04 INFO - building 'psutil._psutil_posix' extension 12:40:04 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 12:40:04 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 12:40:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:40:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:40:05 INFO - Successfully installed psutil 12:40:05 INFO - Cleaning up... 12:40:05 INFO - Return code: 0 12:40:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:40:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:40:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd71a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfce400>, '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 0xfcf3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcf840>, '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': 'd2a8c569965ab8367867b893000001a1-1496171467.168564-1124926776', '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 12:40:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:40:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:40:05 INFO - Using env: {'DISPLAY': ':0', 12:40:05 INFO - 'HOME': '/home/cltbld', 12:40:05 INFO - 'LANG': 'en_US.UTF-8', 12:40:05 INFO - 'LANGUAGE': 'en_US:en', 12:40:05 INFO - 'LOGNAME': 'cltbld', 12:40:05 INFO - 'MAIL': '/var/mail/cltbld', 12:40:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:05 INFO - 'MOZ_NO_REMOTE': '1', 12:40:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:05 INFO - 'NO_EM_RESTART': '1', 12:40:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:05 INFO - 'PWD': '/builds/slave/test', 12:40:05 INFO - 'SHELL': '/bin/bash', 12:40:05 INFO - 'SHLVL': '1', 12:40:05 INFO - 'TERM': 'linux', 12:40:05 INFO - 'TMOUT': '86400', 12:40:05 INFO - 'USER': 'cltbld', 12:40:05 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1496171467.168564-1124926776', 12:40:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:05 INFO - '_': '/tools/buildbot/bin/python'} 12:40:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:40:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:40:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:40:06 INFO - Installing collected packages: mozsystemmonitor 12:40:06 INFO - Running setup.py install for mozsystemmonitor 12:40:06 INFO - Successfully installed mozsystemmonitor 12:40:06 INFO - Cleaning up... 12:40:06 INFO - Return code: 0 12:40:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:40:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:40:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xd331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd71a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfce400>, '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 0xfcf3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcf840>, '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': 'd2a8c569965ab8367867b893000001a1-1496171467.168564-1124926776', '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 12:40:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:40:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:40:06 INFO - Using env: {'DISPLAY': ':0', 12:40:06 INFO - 'HOME': '/home/cltbld', 12:40:06 INFO - 'LANG': 'en_US.UTF-8', 12:40:06 INFO - 'LANGUAGE': 'en_US:en', 12:40:06 INFO - 'LOGNAME': 'cltbld', 12:40:06 INFO - 'MAIL': '/var/mail/cltbld', 12:40:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:06 INFO - 'MOZ_NO_REMOTE': '1', 12:40:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:06 INFO - 'NO_EM_RESTART': '1', 12:40:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:06 INFO - 'PWD': '/builds/slave/test', 12:40:06 INFO - 'SHELL': '/bin/bash', 12:40:06 INFO - 'SHLVL': '1', 12:40:06 INFO - 'TERM': 'linux', 12:40:06 INFO - 'TMOUT': '86400', 12:40:06 INFO - 'USER': 'cltbld', 12:40:06 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1496171467.168564-1124926776', 12:40:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:06 INFO - '_': '/tools/buildbot/bin/python'} 12:40:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:06 INFO - Downloading/unpacking jsonschema==2.5.1 12:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:40:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:40:07 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 12:40:07 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 12:40:07 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 12:40:07 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 12:40:07 INFO - Downloading functools32-3.2.3-2.tar.gz 12:40:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:40:08 INFO - warning: no files found matching '*.txt' 12:40:08 INFO - no previously-included directories found matching 'build' 12:40:08 INFO - no previously-included directories found matching 'dist' 12:40:08 INFO - no previously-included directories found matching '.git*' 12:40:08 INFO - Installing collected packages: jsonschema, functools32 12:40:08 INFO - Running setup.py install for functools32 12:40:08 INFO - warning: no files found matching '*.txt' 12:40:08 INFO - no previously-included directories found matching 'build' 12:40:08 INFO - no previously-included directories found matching 'dist' 12:40:08 INFO - no previously-included directories found matching '.git*' 12:40:08 INFO - Successfully installed jsonschema functools32 12:40:08 INFO - Cleaning up... 12:40:08 INFO - Return code: 0 12:40:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:40:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:40:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd71a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfce400>, '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 0xfcf3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcf840>, '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': 'd2a8c569965ab8367867b893000001a1-1496171467.168564-1124926776', '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 12:40:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:40:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:40:08 INFO - Using env: {'DISPLAY': ':0', 12:40:08 INFO - 'HOME': '/home/cltbld', 12:40:08 INFO - 'LANG': 'en_US.UTF-8', 12:40:08 INFO - 'LANGUAGE': 'en_US:en', 12:40:08 INFO - 'LOGNAME': 'cltbld', 12:40:08 INFO - 'MAIL': '/var/mail/cltbld', 12:40:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:08 INFO - 'MOZ_NO_REMOTE': '1', 12:40:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:08 INFO - 'NO_EM_RESTART': '1', 12:40:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:08 INFO - 'PWD': '/builds/slave/test', 12:40:08 INFO - 'SHELL': '/bin/bash', 12:40:08 INFO - 'SHLVL': '1', 12:40:08 INFO - 'TERM': 'linux', 12:40:08 INFO - 'TMOUT': '86400', 12:40:08 INFO - 'USER': 'cltbld', 12:40:08 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1496171467.168564-1124926776', 12:40:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:08 INFO - '_': '/tools/buildbot/bin/python'} 12:40:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:40:08 INFO - Cleaning up... 12:40:08 INFO - Return code: 0 12:40:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:40:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:40:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd71a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfce400>, '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 0xfcf3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcf840>, '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': 'd2a8c569965ab8367867b893000001a1-1496171467.168564-1124926776', '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 12:40:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:40:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:40:08 INFO - Using env: {'DISPLAY': ':0', 12:40:08 INFO - 'HOME': '/home/cltbld', 12:40:08 INFO - 'LANG': 'en_US.UTF-8', 12:40:08 INFO - 'LANGUAGE': 'en_US:en', 12:40:08 INFO - 'LOGNAME': 'cltbld', 12:40:08 INFO - 'MAIL': '/var/mail/cltbld', 12:40:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:08 INFO - 'MOZ_NO_REMOTE': '1', 12:40:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:08 INFO - 'NO_EM_RESTART': '1', 12:40:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:08 INFO - 'PWD': '/builds/slave/test', 12:40:08 INFO - 'SHELL': '/bin/bash', 12:40:08 INFO - 'SHLVL': '1', 12:40:08 INFO - 'TERM': 'linux', 12:40:08 INFO - 'TMOUT': '86400', 12:40:08 INFO - 'USER': 'cltbld', 12:40:08 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1496171467.168564-1124926776', 12:40:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:08 INFO - '_': '/tools/buildbot/bin/python'} 12:40:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:08 INFO - Downloading/unpacking blobuploader==1.2.4 12:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:09 INFO - Downloading blobuploader-1.2.4.tar.gz 12:40:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:40:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:40:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:10 INFO - Downloading docopt-0.6.1.tar.gz 12:40:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:40:10 INFO - Installing collected packages: blobuploader, requests, docopt 12:40:10 INFO - Running setup.py install for blobuploader 12:40:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:40:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:40:10 INFO - Running setup.py install for requests 12:40:10 INFO - Running setup.py install for docopt 12:40:10 INFO - Successfully installed blobuploader requests docopt 12:40:10 INFO - Cleaning up... 12:40:10 INFO - Return code: 0 12:40:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:40:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:40:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:10 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 0xd331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd71a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfce400>, '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 0xfcf3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcf840>, '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': 'd2a8c569965ab8367867b893000001a1-1496171467.168564-1124926776', '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 12:40:10 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 12:40:10 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 12:40:10 INFO - Using env: {'DISPLAY': ':0', 12:40:10 INFO - 'HOME': '/home/cltbld', 12:40:10 INFO - 'LANG': 'en_US.UTF-8', 12:40:10 INFO - 'LANGUAGE': 'en_US:en', 12:40:10 INFO - 'LOGNAME': 'cltbld', 12:40:10 INFO - 'MAIL': '/var/mail/cltbld', 12:40:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:10 INFO - 'MOZ_NO_REMOTE': '1', 12:40:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:10 INFO - 'NO_EM_RESTART': '1', 12:40:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:10 INFO - 'PWD': '/builds/slave/test', 12:40:10 INFO - 'SHELL': '/bin/bash', 12:40:10 INFO - 'SHLVL': '1', 12:40:10 INFO - 'TERM': 'linux', 12:40:10 INFO - 'TMOUT': '86400', 12:40:10 INFO - 'USER': 'cltbld', 12:40:10 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1496171467.168564-1124926776', 12:40:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:10 INFO - '_': '/tools/buildbot/bin/python'} 12:40:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:40:11 INFO - Running setup.py (path:/tmp/pip-LKUjJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:40:11 INFO - Running setup.py (path:/tmp/pip-NqtgsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:40:11 INFO - Running setup.py (path:/tmp/pip-VvJGTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:40:11 INFO - Running setup.py (path:/tmp/pip-AyHK4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:40:11 INFO - Running setup.py (path:/tmp/pip-0fxW54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:40:11 INFO - Running setup.py (path:/tmp/pip-MD7Wzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:40:11 INFO - Running setup.py (path:/tmp/pip-S6oATZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:40:11 INFO - Running setup.py (path:/tmp/pip-0itkyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:40:11 INFO - Running setup.py (path:/tmp/pip-_04HqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:40:11 INFO - Running setup.py (path:/tmp/pip-mj_yVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:40:11 INFO - Running setup.py (path:/tmp/pip-4fAEIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:40:11 INFO - Running setup.py (path:/tmp/pip-5lSNsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:40:12 INFO - Running setup.py (path:/tmp/pip-7AwK8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:40:12 INFO - Running setup.py (path:/tmp/pip-foWdX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:40:12 INFO - Running setup.py (path:/tmp/pip-t7dm7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:40:12 INFO - Running setup.py (path:/tmp/pip-8AneDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:40:12 INFO - Running setup.py (path:/tmp/pip-ybgsY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:40:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:40:12 INFO - Running setup.py install for manifestparser 12:40:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:40:12 INFO - Running setup.py install for mozcrash 12:40:12 INFO - Running setup.py install for mozdebug 12:40:12 INFO - Running setup.py install for mozdevice 12:40:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:40:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:40:12 INFO - Running setup.py install for mozfile 12:40:12 INFO - Running setup.py install for mozhttpd 12:40:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:40:13 INFO - Running setup.py install for mozinfo 12:40:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:40:13 INFO - Running setup.py install for mozInstall 12:40:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:40:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:40:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:40:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:40:13 INFO - Running setup.py install for mozleak 12:40:13 INFO - Running setup.py install for mozlog 12:40:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:40:13 INFO - Running setup.py install for moznetwork 12:40:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:40:13 INFO - Running setup.py install for mozprocess 12:40:13 INFO - Running setup.py install for mozprofile 12:40:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:40:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:40:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:40:13 INFO - Running setup.py install for mozrunner 12:40:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:40:13 INFO - Running setup.py install for mozscreenshot 12:40:13 INFO - Running setup.py install for moztest 12:40:14 INFO - Running setup.py install for mozversion 12:40:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:40:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:40:14 INFO - Cleaning up... 12:40:14 INFO - Return code: 0 12:40:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:40:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:40:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:14 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 0xd331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd71a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfce400>, '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 0xfcf3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcf840>, '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': 'd2a8c569965ab8367867b893000001a1-1496171467.168564-1124926776', '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 12:40:14 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 12:40:14 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 12:40:14 INFO - Using env: {'DISPLAY': ':0', 12:40:14 INFO - 'HOME': '/home/cltbld', 12:40:14 INFO - 'LANG': 'en_US.UTF-8', 12:40:14 INFO - 'LANGUAGE': 'en_US:en', 12:40:14 INFO - 'LOGNAME': 'cltbld', 12:40:14 INFO - 'MAIL': '/var/mail/cltbld', 12:40:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:14 INFO - 'MOZ_NO_REMOTE': '1', 12:40:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:14 INFO - 'NO_EM_RESTART': '1', 12:40:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:14 INFO - 'PWD': '/builds/slave/test', 12:40:14 INFO - 'SHELL': '/bin/bash', 12:40:14 INFO - 'SHLVL': '1', 12:40:14 INFO - 'TERM': 'linux', 12:40:14 INFO - 'TMOUT': '86400', 12:40:14 INFO - 'USER': 'cltbld', 12:40:14 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1496171467.168564-1124926776', 12:40:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:14 INFO - '_': '/tools/buildbot/bin/python'} 12:40:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:40:14 INFO - Running setup.py (path:/tmp/pip-0MeQTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:40:14 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)) 12:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:40:14 INFO - Running setup.py (path:/tmp/pip-UNoiUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:40:14 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)) 12:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:40:14 INFO - Running setup.py (path:/tmp/pip-tLSTrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:40:14 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)) 12:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:40:14 INFO - Running setup.py (path:/tmp/pip-vHswz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:40:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 12:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:40:14 INFO - Running setup.py (path:/tmp/pip-VvRaPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:40:14 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)) 12:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:40:14 INFO - Running setup.py (path:/tmp/pip-tNN0Ve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:40:14 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)) 12:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:40:14 INFO - Running setup.py (path:/tmp/pip-CsOSjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:40:14 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)) 12:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:40:14 INFO - Running setup.py (path:/tmp/pip-R71D2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:40:14 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)) 12:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:40:14 INFO - Running setup.py (path:/tmp/pip-aHsAN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:40:15 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)) 12:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:40:15 INFO - Running setup.py (path:/tmp/pip-P4fzkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:40:15 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)) 12:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:40:15 INFO - Running setup.py (path:/tmp/pip-PWBALW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:40:15 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)) 12:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:40:15 INFO - Running setup.py (path:/tmp/pip-4XZ6eG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:40:15 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)) 12:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:40:15 INFO - Running setup.py (path:/tmp/pip-O5j39m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:40:15 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)) 12:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:40:15 INFO - Running setup.py (path:/tmp/pip-n_zEFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:40:15 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)) 12:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:40:15 INFO - Running setup.py (path:/tmp/pip-2d9Z1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:40:15 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)) 12:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:40:15 INFO - Running setup.py (path:/tmp/pip-ptZqW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:40:15 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)) 12:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:40:15 INFO - Running setup.py (path:/tmp/pip-rQ_jcs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:40:15 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)) 12:40:15 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)) 12:40:15 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)) 12:40:15 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)) 12:40:15 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:40:15 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:40:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:40:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:16 INFO - Downloading blessings-1.6.tar.gz 12:40:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:40:16 INFO - Installing collected packages: blessings 12:40:16 INFO - Running setup.py install for blessings 12:40:16 INFO - Successfully installed blessings 12:40:16 INFO - Cleaning up... 12:40:16 INFO - Return code: 0 12:40:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:40:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:40:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:40:17 INFO - Reading from file tmpfile_stdout 12:40:17 INFO - Current package versions: 12:40:17 INFO - argparse == 1.2.1 12:40:17 INFO - blessings == 1.6 12:40:17 INFO - blobuploader == 1.2.4 12:40:17 INFO - docopt == 0.6.1 12:40:17 INFO - functools32 == 3.2.3-2 12:40:17 INFO - jsonschema == 2.5.1 12:40:17 INFO - manifestparser == 1.1 12:40:17 INFO - mozInstall == 1.12 12:40:17 INFO - mozcrash == 1.0 12:40:17 INFO - mozdebug == 0.1 12:40:17 INFO - mozdevice == 0.49 12:40:17 INFO - mozfile == 1.2 12:40:17 INFO - mozhttpd == 0.7 12:40:17 INFO - mozinfo == 0.9 12:40:17 INFO - mozleak == 0.1 12:40:17 INFO - mozlog == 3.4 12:40:17 INFO - moznetwork == 0.27 12:40:17 INFO - mozprocess == 0.25 12:40:17 INFO - mozprofile == 0.28 12:40:17 INFO - mozrunner == 6.13 12:40:17 INFO - mozscreenshot == 0.1 12:40:17 INFO - mozsystemmonitor == 0.3 12:40:17 INFO - moztest == 0.8 12:40:17 INFO - mozversion == 1.4 12:40:17 INFO - psutil == 3.1.1 12:40:17 INFO - requests == 1.2.3 12:40:17 INFO - wsgiref == 0.1.2 12:40:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:40: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')]} 12:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40: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')]} 12:40:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:17 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 0xd331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd71a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfce400>, '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 0xfcf3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcf840>, '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': 'd2a8c569965ab8367867b893000001a1-1496171467.168564-1124926776', '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 12:40:17 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 12:40:17 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 12:40:17 INFO - Using env: {'DISPLAY': ':0', 12:40:17 INFO - 'HOME': '/home/cltbld', 12:40:17 INFO - 'LANG': 'en_US.UTF-8', 12:40:17 INFO - 'LANGUAGE': 'en_US:en', 12:40:17 INFO - 'LOGNAME': 'cltbld', 12:40:17 INFO - 'MAIL': '/var/mail/cltbld', 12:40:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:17 INFO - 'MOZ_NO_REMOTE': '1', 12:40:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:17 INFO - 'NO_EM_RESTART': '1', 12:40:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:17 INFO - 'PWD': '/builds/slave/test', 12:40:17 INFO - 'SHELL': '/bin/bash', 12:40:17 INFO - 'SHLVL': '1', 12:40:17 INFO - 'TERM': 'linux', 12:40:17 INFO - 'TMOUT': '86400', 12:40:17 INFO - 'USER': 'cltbld', 12:40:17 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1496171467.168564-1124926776', 12:40:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:17 INFO - '_': '/tools/buildbot/bin/python'} 12:40:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:17 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)) 12:40:17 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)) 12:40:17 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)) 12:40:17 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)) 12:40:17 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)) 12:40:17 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)) 12:40:17 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)) 12:40:17 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)) 12:40:17 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)) 12:40:17 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)) 12:40:17 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)) 12:40:17 INFO - Cleaning up... 12:40:17 INFO - Return code: 0 12:40:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:40: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')]} 12:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40: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')]} 12:40:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:17 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 0xd331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd71a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfce400>, '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 0xfcf3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcf840>, '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': 'd2a8c569965ab8367867b893000001a1-1496171467.168564-1124926776', '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 12:40:17 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 12:40:17 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 12:40:17 INFO - Using env: {'DISPLAY': ':0', 12:40:17 INFO - 'HOME': '/home/cltbld', 12:40:17 INFO - 'LANG': 'en_US.UTF-8', 12:40:17 INFO - 'LANGUAGE': 'en_US:en', 12:40:17 INFO - 'LOGNAME': 'cltbld', 12:40:17 INFO - 'MAIL': '/var/mail/cltbld', 12:40:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:17 INFO - 'MOZ_NO_REMOTE': '1', 12:40:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:17 INFO - 'NO_EM_RESTART': '1', 12:40:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:17 INFO - 'PWD': '/builds/slave/test', 12:40:17 INFO - 'SHELL': '/bin/bash', 12:40:17 INFO - 'SHLVL': '1', 12:40:17 INFO - 'TERM': 'linux', 12:40:17 INFO - 'TMOUT': '86400', 12:40:17 INFO - 'USER': 'cltbld', 12:40:17 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1496171467.168564-1124926776', 12:40:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:17 INFO - '_': '/tools/buildbot/bin/python'} 12:40:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:40:17 INFO - Cleaning up... 12:40:17 INFO - Return code: 0 12:40:17 INFO - Running post-action listener: _resource_record_post_action 12:40:17 INFO - Running post-action listener: _start_resource_monitoring 12:40:17 INFO - Starting resource monitoring. 12:40:17 INFO - [mozharness: 2017-05-30 19:40:17.674487Z] Finished create-virtualenv step (success) 12:40:17 INFO - [mozharness: 2017-05-30 19:40:17.674994Z] Running install step. 12:40:17 INFO - Running pre-action listener: _resource_record_pre_action 12:40:17 INFO - Running main action method: install 12:40:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:40:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:40:17 INFO - Reading from file tmpfile_stdout 12:40:17 INFO - Detecting whether we're running mozinstall >=1.0... 12:40:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:40:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:40:17 INFO - Reading from file tmpfile_stdout 12:40:17 INFO - Output received: 12:40:17 INFO - Usage: mozinstall [options] installer 12:40:17 INFO - Options: 12:40:17 INFO - -h, --help show this help message and exit 12:40:17 INFO - -d DEST, --destination=DEST 12:40:17 INFO - Directory to install application into. [default: 12:40:17 INFO - "/builds/slave/test"] 12:40:17 INFO - --app=APP Application being installed. [default: firefox] 12:40:17 INFO - mkdir: /builds/slave/test/build/application 12:40:17 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'] 12:40:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 12:40:31 INFO - Reading from file tmpfile_stdout 12:40:31 INFO - Output received: 12:40:31 INFO - /builds/slave/test/build/application/firefox/firefox 12:40:31 INFO - Running post-action listener: _resource_record_post_action 12:40:31 INFO - [mozharness: 2017-05-30 19:40:31.967397Z] Finished install step (success) 12:40:31 INFO - [mozharness: 2017-05-30 19:40:31.967626Z] Running run-tests step. 12:40:31 INFO - Running pre-action listener: _resource_record_pre_action 12:40:31 INFO - Running main action method: run_tests 12:40:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:40:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:40:31 INFO - Python 2.7.3 12:40:31 INFO - Return code: 0 12:40:31 INFO - grabbing minidump binary from tooltool 12:40:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:40:31 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 0xfce400>, '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 0xfcf3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcf840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:40:31 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 12:40:31 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 12:40:31 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 12:40:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:40:32 INFO - Return code: 0 12:40:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:40:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:40:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:40:32 INFO - ENV: RUST_BACKTRACE is now 1 12:40:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:40:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:40:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GwP3vRZZRVuz-R5itW5BeQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 12:40:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GwP3vRZZRVuz-R5itW5BeQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-043 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 12:40:32 INFO - Using env: {'DISPLAY': ':0', 12:40:32 INFO - 'HOME': '/home/cltbld', 12:40:32 INFO - 'LANG': 'en_US.UTF-8', 12:40:32 INFO - 'LANGUAGE': 'en_US:en', 12:40:32 INFO - 'LOGNAME': 'cltbld', 12:40:32 INFO - 'MAIL': '/var/mail/cltbld', 12:40:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:40:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:40:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:32 INFO - 'MOZ_NO_REMOTE': '1', 12:40:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:40:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:32 INFO - 'NO_EM_RESTART': '1', 12:40:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:32 INFO - 'PWD': '/builds/slave/test', 12:40:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:40:32 INFO - 'RUST_BACKTRACE': '1', 12:40:32 INFO - 'SHELL': '/bin/bash', 12:40:32 INFO - 'SHLVL': '1', 12:40:32 INFO - 'TERM': 'linux', 12:40:32 INFO - 'TMOUT': '86400', 12:40:32 INFO - 'USER': 'cltbld', 12:40:32 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1496171467.168564-1124926776', 12:40:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:32 INFO - '_': '/tools/buildbot/bin/python'} 12:40:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GwP3vRZZRVuz-R5itW5BeQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 12:40:32 INFO - mozversion application_buildid: 20170530184525 12:40:32 INFO - mozversion application_changeset: b6b58f56432af99bc6b8356da3ea96170a04190e 12:40:32 INFO - mozversion application_display_name: Firefox 12:40:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:40:32 INFO - mozversion application_name: Firefox 12:40:32 INFO - mozversion application_remotingname: firefox 12:40:32 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:40:32 INFO - mozversion application_vendor: Mozilla 12:40:32 INFO - mozversion application_version: 54.0 12:40:32 INFO - mozversion platform_buildid: 20170530184525 12:40:32 INFO - mozversion platform_changeset: b6b58f56432af99bc6b8356da3ea96170a04190e 12:40:32 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:40:32 INFO - mozversion platform_version: 54.0 12:40:32 INFO - using testdate: 1496173232 12:40:32 INFO - actual date: 1496173232 12:40:32 INFO - starting webserver on 'localhost:44620' 12:40:32 INFO - SUITE-START | Running 2 tests 12:40:32 INFO - TEST-START | dromaeo_css 12:40:32 INFO - operating with platform_type : linux_ 12:40:32 INFO - Initialising browser for dromaeo_css test... 12:40:32 INFO - TEST-INFO | started process 29390 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_BrW3R/profile http://localhost:44620/getInfo.html) 12:40:37 INFO - PROCESS | 29390 | __metrics Screen width/height:1600/1200 12:40:37 INFO - PROCESS | 29390 | colorDepth:24 12:40:37 INFO - PROCESS | 29390 | Browser inner width/height: 1024/697 12:40:37 INFO - PROCESS | 29390 | __metrics 12:40:38 INFO - PROCESS | 29390 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:40:38 INFO - PROCESS | 29390 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:40:39 INFO - TEST-INFO | 29390: exit 0 12:40:39 INFO - Browser initialized. 12:40:39 INFO - Running cycle 1/1 for dromaeo_css test... 12:40:39 INFO - TEST-INFO | started process 29484 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_BrW3R/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:40:50 INFO - PROCESS | 29484 | RSS: Main: 142049280 12:40:50 INFO - PROCESS | 29484 | 12:43:52 INFO - PROCESS | 29484 | Cycle 1(1): loaded http://localhost:44620/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44620/tests/dromaeo/cssquery-ext.html) 12:43:53 INFO - PROCESS | 29484 | RSS: Main: 257396736 12:43:53 INFO - PROCESS | 29484 | 12:46:55 INFO - PROCESS | 29484 | Cycle 1(1): loaded http://localhost:44620/tests/dromaeo/cssquery-ext.html (next: http://localhost:44620/tests/dromaeo/cssquery-jquery.html) 12:46:56 INFO - PROCESS | 29484 | RSS: Main: 224370688 12:46:56 INFO - PROCESS | 29484 | 12:49:58 INFO - PROCESS | 29484 | Cycle 1(1): loaded http://localhost:44620/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44620/tests/dromaeo/cssquery-mootools.html) 12:49:58 INFO - PROCESS | 29484 | RSS: Main: 227016704 12:49:58 INFO - PROCESS | 29484 | 12:53:00 INFO - PROCESS | 29484 | Cycle 1(1): loaded http://localhost:44620/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44620/tests/dromaeo/cssquery-prototype.html) 12:53:01 INFO - PROCESS | 29484 | RSS: Main: 209182720 12:53:01 INFO - PROCESS | 29484 | 12:56:04 INFO - PROCESS | 29484 | Cycle 1(1): loaded http://localhost:44620/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44620/tests/dromaeo/cssquery-yui.html) 12:56:04 INFO - PROCESS | 29484 | RSS: Main: 176177152 12:56:04 INFO - PROCESS | 29484 | 12:59:07 INFO - PROCESS | 29484 | Cycle 1(1): loaded http://localhost:44620/tests/dromaeo/cssquery-yui.html (next: http://localhost:44620/tests/dromaeo/cssquery-dojo.html) 12:59:07 INFO - PROCESS | 29484 | RSS: Main: 260792320 12:59:07 INFO - PROCESS | 29484 | 12:59:07 INFO - PROCESS | 29484 | __start_tp_report 12:59:07 INFO - PROCESS | 29484 | _x_x_mozilla_page_load 12:59:07 INFO - PROCESS | 29484 | _x_x_mozilla_page_load_details 12:59:07 INFO - PROCESS | 29484 | |i|pagename|runs| 12:59:07 INFO - PROCESS | 29484 | |0;dojo.html;3376.6960973512387;3399.9830000849993;3460.100373902786;3466.7746596471243;3499.685028347448;5673.659580425177;5749.59752817303;5766.221560089392;5770.884582308351;5774.451427114417;5721.284839395075;5791.362950075489;5792.986227410207;5798;5806.158107074471;5224.738763061841;5234.869128271805;5274.683518988873;5275.393329767068;5320.441353657869;5070.771815268322;5124.513171248744;5298.841034768944;5318.574514038867;5320.255164277004;5173.896522069556;5183.481651834824;5197.402298735656;5212.687238765668;5221.530062294392;5296.020236256305;5296.655717378358;5300.31095957523;5304.151335786294;5316.73416329182;5061.342025536656;5160.458151894035;5226.111561034633;5272.499112584298;5279.260903473517;5612.270404847384;5621.80323688673;5635.830925072254;5682.147677848315;5690.9146362804595;6103.267607887082;6138.815835524942;6145.78489752861;6157.661328626924;6161.353057928898;6166.660833654148;6167.969160154171;6176.320604733476;6186.628802271833;6188.381161883775;5526.419725928759;5561.193626924114;5680.5171560417;5717.371089180187;5718.571107166979;6259.561830671809;6276;6280.717367718464;6281.214848143982;6281.59169653971;5983.309558483666;6037.72830222641;6052.394760523913;6053.939460605426;6055.757769689163;5912.9113063304085;5978.910316345258;6066.302375226817;6108.450239478379;6134.570580059442;6127.017204504704;6135.8334873451895;6135.875804921915;6136.097809679014;6142.262928448615;5922.970385148046;5940.34656187819;5951.345352011275;5958.523318134626;6144.003198960356;4582.152301824173;4639.930401043919;4642.442906851199;4644.95355046452;4684.016356565091;4201.789910504463;4210.242156411875;4221.345691417835;4238.067625122468;4241.936370954438;5720.227769251181;5738.626989245686;5913.319968203712;5920.615160014585;5920.644761314335;6161.045038019114;6165.32181460039;6191.907121393183;6196.287426945959;6197.4732147767945;5906.527477801766;5915.231019967377;5921.763129474859;5925.05199168131;5939.940600594025;5077.796888124433;5101.2603172539775;5232.659877107976;5256.526912577886;5261.421243663194;6343.619382837044;6375.553711240169;6378.585391949508;6427.3251308611925;6456.9354306456335;6082;6131.570790044832;6136.693165341626;6137.60105593135;6173.969130154321;6359.777407790705;6442.09810626522;6446.580972236789;6447.806565803034;6450.741970321323;5844.824655260349;5854.443827836349;5974.014287642491;5981.581289309706;6011.609245399035;6171.074338849029;6176.6911654418;6180.072989051679;6185.597936134317;6193.411625895533;5993.520518358434;6025.8192254232445;6050.606710563799;6053.552956154918;6061.696915154313;5734.369219385948;5759;5960.612560183574;5967.6419414835245;6045.818625441244;6012.759489620541;6013.398660133952;6028.457438830526;6042.728077236623;6052.122442245938;5852.385499522489;5876.118582212703;6062.242219722535;6062.6665533394325;6069.848253793691;5800.1299805029585;5860.619059761102;5877.706114694333;5882.941170588239;5891.793787217427 12:59:07 INFO - PROCESS | 29484 | |1;ext.html;785.1638005524117;836.4103307168447;861.8577934640787;909.3316412436853;919.5402298850574;32337;34537.30925381491;34546.65453345466;43575.56424435755;44004.33993490092;45634.543654563444;45805;45988.31017534732;46039;46144.538554614446;8970.910290897073;9133.862992055125;9140.131687489678;9140.542972851365;9148.451092934412;7598.772036838904;7733.613319334039;8946.597403116875;10537.73655658611;10841.728956776065;10821.729456763565;10846;10878.347299162037;10880.891191088107;10886.40124793136;10793.514291856885;10794.5682172713;10814.35113893165;10815.134789216843;10828.350298982046;10595.311304765242;10626.946865265701;10633.57465701371;10647;10654.786904261871;42457.78771106156;42661.786691066656;42850.35724464135;42913.57086429127;43059.13881722379;4294.463192100988;4345.435093437833;4388.780560971971;4466;4484.753338566377;30659.693403065907;30917.0724878254;31053.84473077643;31286.53070203926;32064.19839504008;3970.980145099256;3995.6603688686496;4020.2361551305157;4042.6765858731233;4092.631663150331;224064;224328;224494;224932.87533562392;226347;53083.469165307855;53204.46795531995;53216;53264.46735532595;53314;55882;56046.15930761042;56082.71958640181;56106;56274.43725562774;15907.125108119164;16319.265633046542;16360.10019448918;16372.836271637369;16385.09881956504;14420.134791912518;14431.855681443261;14434.350454229585;14456.638584035272;14475.203863787383;11306.265092768943;11501.597444089417;11822;13088.803667944989;13148.737025259632;5427.620066595379;5520.666276972557;5532.2531458253425;5538.833834984957;5576.33084029919;1017.704865588971;1021.8722659667542;1033.565902321027;1043.6451606453843;1060.157175045825;27518.44963100767;28010.71989280122;28149.57775633367;28344.574831377548;28489.71510284912;1088.580896354909;1104.536094840169;1105.950232239551;1117.402189828438;1121.6354684727332;14293.356798944073;15104.54686359411;15157.393704251926;15214.315355809014;15334.616634584225;296820;297359;297861;297893;298000;55596.722016389656;55686.72156639191;55734.44265557374;55746.442535574126;55806.44193558012;1478.090974050951;1480.9259537023322;1509.8641122299045;1521.7108749337813;1567.7569976653408;27675.86162069177;27885.58171627468;28580.714192857806;28917.56623650605;29237.561436578042;36534.269314613026;36573.817130914176;36698.63301367059;36758.63241367659;36771.63228367682;282166;283226;283242;283610;284400;26933;27491.587626186025;27731.306717332227;30403;30475.2381190472;32397.35205295928;32635.673643264214;32669.836650816593;33650.49524257187;36413.817930910176;25261.368465788502;31439;31458.842705786323;31467.685323146474;31847.68152318447;31142;31148.22129446782;31557.8422107888;31695.52456713197;31858.20354491156;35525;35529.822350888084;35663.46504802482;35774.642253577134;36546.26907461783;30166.245843854078;30194.849025755608;30287.697123028487;30430.54354184733;30745;23814.523709525365;24896.62655060212;24930.252092437255;25016.749832501442;25163.87418062898 12:59:07 INFO - PROCESS | 29484 | |2;jquery.html;459.7310573314611;473.176672589694;482.2115840600619;483.26784920844915;491.2214140587169;20028.399148025546;21827.126914923403;22470.66294005591;22576.43558911026;22720.43198920028;22696;22731;23053.308400748003;23214.65178022331;23226.535469290604;6638.203415590136;6755.628440435762;6825.078614387068;6858.3141685831515;6863.828404289908;6720.663966801665;6886.793396198122;7200.459965502609;7497;7541.396688264953;7322.963385183067;7523.172451030382;7526.397888168934;7535.20880307568;7536.095668519785;7463.402927765793;7657.808554786119;7663.386929045663;7703.614819259014;7707.383409327241;7238.855222895512;7439.4792364534505;7471.327580517725;7482.251774822528;7490.588017659026;24726.629100563507;25135;25450.49099018028;26347.868260658764;26725.73274267252;3488.4592888102384;3559.2169722660974;3583.8566457341676;3597.6402359764074;3616.7287453440836;16399;16502.75245871313;16653.16734163287;16662.50012499627;16711.66576668472;2322.5354929014097;2392.4497365606007;2393.5452264069772;2399.484110916144;2451.0563433078214;111182.44408777905;115258.48929312095;117045.41477292644;121769;124012.37993809974;17853.196606152494;18054.638907221783;18187.63624727498;18198.5450363742;18571.16429760664;32377.19057023546;32465.51301730476;32477;32504.837475812943;32803.34393312121;10557.47212639365;10626.14990800734;10663.146948244123;10709.196810239264;10860.891391085988;9042.140996605312;9072.138146876036;9119.635214591475;9256.768580785534;9289.62841486333;9037.141471560191;9357;9407.153356197976;9430.245580353556;9694.563744631367;3432.2667053138007;3475.4786781982907;3561.821908904596;3641.1807343347537;3787.50442990273;958.836997710391;967.7967626798311;972.3242346569067;974.1914211204684;982.2093214961882;20041.899790500953;20790.58418831615;21221.469463263235;21390.572188556143;21666.89166554157;982.8083374075851;988.7231575158967;994.3195998762069;999.7000899730198;1014.1531820929606;11209.21535492524;11669.416529173508;11736.119791015537;11763.176577639655;11907.404629768476;666630;668397;676267;682029;683374;88022;111774.44112779383;114787;115441;117108.41445792717;1229.8647148813623;1248.6129299917054;1272.2557303977092;1279.0215485153865;1281.8397700287464;18052.909735451238;18393.632127357647;18481.53796155107;18534;18933.148008339933;52237;53218.46781532135;53228;53558;54001;70190.64904675444;70340.94488582572;70630;71284;71488;11311.830322545004;12773.552925647558;12899.548515801902;12900.935495322463;12957.740845183233;13471.46114155462;13709.725805484033;13763.724725505634;14734.189619571027;14766.77849832232;7360.815979600553;12338.81491777606;12497.18768280059;12846.550370736979;12974.805377919527;11981.880181198425;12012.699682508008;12048.75902481928;12060.51757929673;12296.446659900505;12528.436220369922;12580.119391642496;12600.306983116017;12735.872641273469;12805.231686098863;12541.435635396612;12577.559785407833;12693.301868397326;12695.55565555201;13065.608031759062;12418.503259869503;12495.437705303102;12559.372031398576;12992.935035325141;13212.273324967218 12:59:07 INFO - PROCESS | 29484 | |3;mootools.html;1401.2923473645808;1552.44888064737;1553.2311505804626;1569.7741141953288;1575.2045217165332;9332.813343733122;10868.728281792959;11231.66305010851;11257.60598379056;11262.887371126286;11383;11443.313401195934;11454.541818327258;11464.656060318182;11465.770684586303;2084.843636727244;2134.50906291553;2488.054539275073;2526.987365063172;2529.6458495810602;2483.7019557653107;2563.102913980101;2571.1386685460393;2572.498362819251;2573.4338445541953;2496.2261698873317;2519.60946053362;2526;2528.911488097917;2532.3669082729316;2477.046337160188;2500.2874180858457;2508.147229941819;2508.385445565839;2520.785733212679;2364.054378248697;2377.667126602277;2396.9041238350446;2398.280515845257;2402.483466054789;11264.718382040433;11447.771044579145;11454.48454819535;11469.827952580634;11481.540738370455;5877.235959325303;6011;6020;6021.759129634809;6023.397660233985;3480.617132115465;3508.5263489428858;3557;3628.8004159771203;3679.963200367989;1345.7173993461386;1353;1354.356680576728;1406.2265753835452;1427.3933578229314;16663.6667266654;16797.244124014327;16903.915480422642;16914.492565223063;16973.405930792364;4888.413390393175;4927.926081108786;4956.925646115311;5097.209932460474;5199.636025478256;13870.930645346709;13947.093438926437;13949.302534873215;13958;13964.790528142086;6037.335893051761;6044.304904935901;6062.575619706667;6065.636061836304;6072.967595508774;5448.42791506894;5533.170024496358;5649.858753531194;5689.800856969986;5699.857503562444;4185.727927684691;4272.786360681954;4280.13813990915;4327.913441731148;4338.305871060678;1168.6318809575127;1189.1616410430627;1197.0722689915385;1205.1624121235832;1206.7827790997706;1034.6171916390983;1044.2064031336088;1053.773438710681;1057.6774083904484;1058.85705429766;7241;7500.924990750132;7531.661075251627;7575;7735.613219339123;1045.153425725165;1045.1586472889246;1056.7199692081604;1059.2373491086405;1084.511969613677;4699.318598803155;4793.520647935178;4826.734529600905;4844.878878028077;4888.9755551222015;14134.36395362211;14860.479883204036;14889.106653600818;14891.106533608017;14893.70212595742;13697.863021369858;14103.85896141046;14667.559973200821;14711.632209194642;14727;10339.0694837465;10487.475626218658;10529.947350263354;10534.420606866695;10600.310979786289;7267.563946163035;7603.353714934293;7612.162662107053;7661.348785353307;7752.341051010727;12791.616251512469;12845.35773211317;13048.673783155118;13055.543055992996;13089;10863.728406789893;11784.764304713686;13030.41363138642;13094.607161785161;13114.475420983053;9610.279229057709;9686.612535498502;9790.706278811647;9816.705498835046;9917.851232231667;10008.599656013677;10035.19718422539;10082.546285417027;10099.192064634664;10115.140213081677;9169.633214671605;9306.395084319498;9335.159835614828;9460.053994600485;9536.952315238379;8994.86507702398;9110.180083792491;9222.44665320083;9431.717048488556;9486.905130948602;8583.484990900566;8594.957025215084;8610.870836937325;8668.653253870027;8703.477791332287;6224.502039836711;6289.7484100635465;6385.584936979081;6405.8718825624155;6506.056621789909;6353.745850166127;6457.160569125984;6473.967630161819;6505.60966342002;6719.563228390139 12:59:07 INFO - PROCESS | 29484 | |4;prototype.html;422.640755357946;424.2321398269133;441.77690266415476;447.16157205240177;451.56649616368287;5260.842174734755;5268.973655131728;5273.018870752581;5298.258243845855;5304.946950530493;5089.2620570017325;5149;5217.582593392529;5225.190095535198;5265.420803711589;4439.866803995869;4444.933326000112;4445.733256004634;4452.8441504547345;4455.443069616298;4467.865964021084;4492.550744925514;4493.932591011137;4499.370088187657;4551.180787458256;4321.314687271966;4470.100207411853;4489.2817149256125;4489.775511224442;4547.727136371828;4454.420925279725;4459.951911300842;4472.217361961676;4473.552644735533;4477.582105662938;4190.958090419118;4214.73557932622;4239.576042395766;4244.808983595745;4264.594863487995;4970.428400733926;5150.484951504857;5185.818496352647;5251.186066159751;5322.654027488201;5148.5623721983675;5154.871128221787;5171.715555644438;5182.948170518284;5190.948090519084;5563.054280772238;5595.412481689405;5602.579806514527;5636.605437619368;5650.971745141289;4334.869953901388;4592.88517787058;4597.195490789099;4598.241290187115;4702.670813043088;5513.972430137824;5580.637258578179;5664.745086471077;5727.3699893011735;5748.683822389767;4689.390379250675;4695.413073365829;4700.482946875841;4704.976475117671;4737.668363214542;4557.680962332671;4632.189366860786;4639.907201855944;4760.09558183944;4781.163296423112;5069.721165335942;5091.949080509222;5099.719515426687;5101.138084599094;5103.902660927844;5482.91775623366;5519.944800551943;5540.63985840919;5544.251526044013;5554.611517047709;1593.9043657380594;1626.6336277526934;1655.9420420285232;1661.5264649574813;1663.5924198571427;1227.8281040654315;1248.9875101249054;1267.0560432477862;1272.7272727272727;1276.869970076489;5425.941941321484;5456.181572764038;5462.945370546323;5463.399026107125;5514.696691681916;5612.943870561324;5657.405972372924;5729.742161602738;5762.423757624204;5775.220345253421;5296.549793267615;5388.602072077966;5414;5437.32033495813;5465.6447330923365;2948.248196709825;2979.4339075576004;2998.4752668282963;3003.9549406758915;3014.8643311051055;5623.959567480029;5920.881582368328;5921.496672782861;5951.315598706117;5957.076653118774;5777.711114444261;5778.306603207558;5785.971070144622;5792.247007889032;5808.6224395414165;5905.320888097752;5919.970400147971;5946.256717910262;5947.6431414115295;5981.491573216325;5514.476124768141;5593.349961761209;5651.745671444877;5695.231143795535;5698.886022279448;5387.461253874581;5476.972615136899;5564.690653378802;5609.691466969356;5635.549156067423;5826.067829147316;5865.912011319749;5911.172435859069;5953.821385358447;5959.22530071088;4666.393368862026;4729.574338309569;4731.810727570859;4784.593309568587;4788.11419887322;5526.281583394133;5665.518430933417;5717.1995920570325;5754.3670196277535;5806.44838740319;5519.957615682223;5524.14375771756;5548.778048878;5560.7756897241425;5567.359753628222;5326.25432439451;5599.60802743804;5627.943720562906;5629;5642.85892852682;5475.206095116266;5477.75350109238;5483.670979741229;5486.423925487767;5513.365962914316;5534.505683465522;5554.50009499147;5556.666600004012;5618.297712785902;5628.831135065954;5206.687598744087;5419.376771671308;5446.482584154499;5455;5478.945210547843 12:59:07 INFO - PROCESS | 29484 | |5;yui.html;841.7264389073553;891.8662200669903;892.2371372476529;937.2567025332881;945.5225111318781;15731.764023539641;16699.998000120002;17298;18022.729659055123;18693.34573289935;18494.16776245069;18770.34303799364;19160.712589311137;19191.80808191921;19296.71054934177;904.5703290936818;928.7538802217417;929.2008872369756;929.4098247612746;930.1582068228264;892.9330300227476;894.5259012723267;896.4621227263623;909.56340956341;932.2169377722712;944.6363150187193;945.0502245243521;946.1153821177221;947.3652652722658;947.5357075033219;940.7742141885932;940.8212439636447;940.9670661526848;943.8253923024229;944.1927152284835;697.3758486154863;701.4984286235366;702.0311969482133;702.3608516250239;702.8805103132429;16602.418915338025;16656.167191640492;16674.58313542159;18479;18801.623967520572;15580.688386232325;15952.4416645418;16212.351505939749;16264.105474198914;16512.669746605;13410.865891341156;13984.650383740387;14033;14052.156870587798;14076;4011.5186177658575;4063.878083657495;4091.2226676931286;4146.854860079883;4168.958310416887;88928;89373;90423.54788226083;90924.54537727269;93730.53134734283;11954.760904781855;12001.459934302977;12064.819027714591;12109.212901161396;12461.626151215478;21714.24000159987;22427.102915883508;24076.277711668678;24089.156879509133;24106;9292.628294868266;9392.201662858597;9455.14903658674;9492.240620750461;9496.762580935532;5040.722760248222;5107.770150343244;5189.818356357509;5195.11683013881;5305.495977882095;3786.4888240087234;3890.183061557105;4027.838886444568;4243.6605071594195;4322.459692538433;686.3856848120904;693.6081114170478;694.1011390249639;702.8242939265184;710.1761956130863;637.3499030988365;638.1894993358409;640.5644161969813;668.2081733146238;839.4837175137246;11407.48666310018;11538.538458461568;11670.241434306743;11941.283522988648;12384.81422778659;608.716946619824;624.5752888036179;626.064034268762;644.1497223664718;878.1438097854668;5235.502627250406;5412.945870541244;5531.612787104945;5536.833894983157;5546.639468434539;75020.62489687625;85860;86029;86549.56725216334;88749.55625221833;46718.76640616843;48512.27231591529;61550.69224653848;71962;74166;62744.686276568325;63598.36401636017;63861;64021.35978640247;64986.35013649898;10556.313839600401;11031.83452248233;11196.712378076625;11325.943370283096;11378.37418941933;38967.805160974014;39950.80024599859;43240.783796082076;44742;44900.326495101945;47848.760756197385;48539.02921941612;56311;57938.7103064482;58702;12779.297138657463;12815.743685126059;12841.10112292168;12887.097903147065;13029.022823288102;16430.507084787474;16589.66820663604;16734;16792.58018549546;17017.659646806747;15714.76427853606;16052;16656.833431665527;16683.249253783368;17136.14319284056;14670.193139377438;15107.32017059213;15124.39502419891;15223.695526089195;15833.129177895325;14287.57137285883;15856.841431585537;16169.353225870833;16498.25757840924;16707.582310442336;11724.70688232801;11747.530098795953;12361.62915112548;12409.503619855104;12726.809097863725;11501.597444089417;13060.21638701681;13121.475140994253;13204.669883252996;13501.122427042212 12:59:07 INFO - PROCESS | 29484 | __end_tp_report 12:59:07 INFO - PROCESS | 29484 | __start_cc_report 12:59:07 INFO - PROCESS | 29484 | _x_x_mozilla_cycle_collect,1113 12:59:07 INFO - PROCESS | 29484 | __end_cc_report 12:59:07 INFO - PROCESS | 29484 | __startTimestamp1496174347441__endTimestamp 12:59:07 INFO - PROCESS | 29484 | 12:59:07 INFO - PROCESS | 29484 | ------- Summary: start ------- 12:59:07 INFO - PROCESS | 29484 | Number of tests: 6 12:59:07 INFO - PROCESS | 29484 | 12:59:07 INFO - PROCESS | 29484 | [#0] dojo.html Cycles:165 Average:5700.51 Median:5920.62 stddev:636.22 (10.7%) stddev-sans-first:611.50 12:59:07 INFO - PROCESS | 29484 | Values: 3376.7 3400.0 3460.1 3466.8 3499.7 5673.7 5749.6 5766.2 5770.9 5774.5 5721.3 5791.4 5793.0 5798.0 5806.2 5224.7 5234.9 5274.7 5275.4 5320.4 5070.8 5124.5 5298.8 5318.6 5320.3 5173.9 5183.5 5197.4 5212.7 5221.5 5296.0 5296.7 5300.3 5304.2 5316.7 5061.3 5160.5 5226.1 5272.5 5279.3 5612.3 5621.8 5635.8 5682.1 5690.9 6103.3 6138.8 6145.8 6157.7 6161.4 6166.7 6168.0 6176.3 6186.6 6188.4 5526.4 5561.2 5680.5 5717.4 5718.6 6259.6 6276.0 6280.7 6281.2 6281.6 5983.3 6037.7 6052.4 6053.9 6055.8 5912.9 5978.9 6066.3 6108.5 6134.6 6127.0 6135.8 6135.9 6136.1 6142.3 5923.0 5940.3 5951.3 5958.5 6144.0 4582.2 4639.9 4642.4 4645.0 4684.0 4201.8 4210.2 4221.3 4238.1 4241.9 5720.2 5738.6 5913.3 5920.6 5920.6 6161.0 6165.3 6191.9 6196.3 6197.5 5906.5 5915.2 5921.8 5925.1 5939.9 5077.8 5101.3 5232.7 5256.5 5261.4 6343.6 6375.6 6378.6 6427.3 6456.9 6082.0 6131.6 6136.7 6137.6 6174.0 6359.8 6442.1 6446.6 6447.8 6450.7 5844.8 5854.4 5974.0 5981.6 6011.6 6171.1 6176.7 6180.1 6185.6 6193.4 5993.5 6025.8 6050.6 6053.6 6061.7 5734.4 5759.0 5960.6 5967.6 6045.8 6012.8 6013.4 6028.5 6042.7 6052.1 5852.4 5876.1 6062.2 6062.7 6069.8 5800.1 5860.6 5877.7 5882.9 5891.8 12:59:07 INFO - PROCESS | 29484 | 12:59:07 INFO - PROCESS | 29484 | [#1] ext.html Cycles:180 Average:43429.78 Median:30452.89 stddev:70511.38 (231.5%) stddev-sans-first:70636.49 12:59:07 INFO - PROCESS | 29484 | Values: 785.2 836.4 861.9 909.3 919.5 32337.0 34537.3 34546.7 43575.6 44004.3 45634.5 45805.0 45988.3 46039.0 46144.5 8970.9 9133.9 9140.1 9140.5 9148.5 7598.8 7733.6 8946.6 10537.7 10841.7 10821.7 10846.0 10878.3 10880.9 10886.4 10793.5 10794.6 10814.4 10815.1 10828.4 10595.3 10626.9 10633.6 10647.0 10654.8 42457.8 42661.8 42850.4 42913.6 43059.1 4294.5 4345.4 4388.8 4466.0 4484.8 30659.7 30917.1 31053.8 31286.5 32064.2 3971.0 3995.7 4020.2 4042.7 4092.6 224064.0 224328.0 224494.0 224932.9 226347.0 53083.5 53204.5 53216.0 53264.5 53314.0 55882.0 56046.2 56082.7 56106.0 56274.4 15907.1 16319.3 16360.1 16372.8 16385.1 14420.1 14431.9 14434.4 14456.6 14475.2 11306.3 11501.6 11822.0 13088.8 13148.7 5427.6 5520.7 5532.3 5538.8 5576.3 1017.7 1021.9 1033.6 1043.6 1060.2 27518.4 28010.7 28149.6 28344.6 28489.7 1088.6 1104.5 1106.0 1117.4 1121.6 14293.4 15104.5 15157.4 15214.3 15334.6 296820.0 297359.0 297861.0 297893.0 298000.0 55596.7 55686.7 55734.4 55746.4 55806.4 1478.1 1480.9 1509.9 1521.7 1567.8 27675.9 27885.6 28580.7 28917.6 29237.6 36534.3 36573.8 36698.6 36758.6 36771.6 282166.0 283226.0 283242.0 283610.0 284400.0 26933.0 27491.6 27731.3 30403.0 30475.2 32397.4 32635.7 32669.8 33650.5 36413.8 25261.4 31439.0 31458.8 31467.7 31847.7 31142.0 31148.2 31557.8 31695.5 31858.2 35525.0 35529.8 35663.5 35774.6 36546.3 30166.2 30194.8 30287.7 30430.5 30745.0 23814.5 24896.6 24930.3 25016.7 25163.9 12:59:07 INFO - PROCESS | 29484 | 12:59:07 INFO - PROCESS | 29484 | [#2] jquery.html Cycles:180 Average:38419.67 Median:2393.00 stddev:111215.76 (4647.6%) stddev-sans-first:111491.22 12:59:07 INFO - PROCESS | 29484 | Values: 459.7 473.2 482.2 483.3 491.2 20028.4 21827.1 22470.7 22576.4 22720.4 22696.0 22731.0 23053.3 23214.7 23226.5 6638.2 6755.6 6825.1 6858.3 6863.8 6720.7 6886.8 7200.5 7497.0 7541.4 7323.0 7523.2 7526.4 7535.2 7536.1 7463.4 7657.8 7663.4 7703.6 7707.4 7238.9 7439.5 7471.3 7482.3 7490.6 24726.6 25135.0 25450.5 26347.9 26725.7 3488.5 3559.2 3583.9 3597.6 3616.7 16399.0 16502.8 16653.2 16662.5 16711.7 2322.5 2392.4 2393.5 2399.5 2451.1 111182.4 115258.5 117045.4 121769.0 124012.4 17853.2 18054.6 18187.6 18198.5 18571.2 32377.2 32465.5 32477.0 32504.8 32803.3 10557.5 10626.1 10663.1 10709.2 10860.9 9042.1 9072.1 9119.6 9256.8 9289.6 9037.1 9357.0 9407.2 9430.2 9694.6 3432.3 3475.5 3561.8 3641.2 3787.5 958.8 967.8 972.3 974.2 982.2 20041.9 20790.6 21221.5 21390.6 21666.9 982.8 988.7 994.3 999.7 1014.2 11209.2 11669.4 11736.1 11763.2 11907.4 666630.0 668397.0 676267.0 682029.0 683374.0 88022.0 111774.4 114787.0 115441.0 117108.4 1229.9 1248.6 1272.3 1279.0 1281.8 18052.9 18393.6 18481.5 18534.0 18933.1 52237.0 53218.5 53228.0 53558.0 54001.0 70190.6 70340.9 70630.0 71284.0 71488.0 11311.8 12773.6 12899.5 12900.9 12957.7 13471.5 13709.7 13763.7 14734.2 14766.8 7360.8 12338.8 12497.2 12846.6 12974.8 11981.9 12012.7 12048.8 12060.5 12296.4 12528.4 12580.1 12600.3 12735.9 12805.2 12541.4 12577.6 12693.3 12695.6 13065.6 12418.5 12495.4 12559.4 12992.9 13212.3 12:59:07 INFO - PROCESS | 29484 | 12:59:07 INFO - PROCESS | 29484 | [#3] mootools.html Cycles:180 Average:7174.80 Median:2504.22 stddev:4493.80 (179.4%) stddev-sans-first:4485.46 12:59:07 INFO - PROCESS | 29484 | Values: 1401.3 1552.4 1553.2 1569.8 1575.2 9332.8 10868.7 11231.7 11257.6 11262.9 11383.0 11443.3 11454.5 11464.7 11465.8 2084.8 2134.5 2488.1 2527.0 2529.6 2483.7 2563.1 2571.1 2572.5 2573.4 2496.2 2519.6 2526.0 2528.9 2532.4 2477.0 2500.3 2508.1 2508.4 2520.8 2364.1 2377.7 2396.9 2398.3 2402.5 11264.7 11447.8 11454.5 11469.8 11481.5 5877.2 6011.0 6020.0 6021.8 6023.4 3480.6 3508.5 3557.0 3628.8 3680.0 1345.7 1353.0 1354.4 1406.2 1427.4 16663.7 16797.2 16903.9 16914.5 16973.4 4888.4 4927.9 4956.9 5097.2 5199.6 13870.9 13947.1 13949.3 13958.0 13964.8 6037.3 6044.3 6062.6 6065.6 6073.0 5448.4 5533.2 5649.9 5689.8 5699.9 4185.7 4272.8 4280.1 4327.9 4338.3 1168.6 1189.2 1197.1 1205.2 1206.8 1034.6 1044.2 1053.8 1057.7 1058.9 7241.0 7500.9 7531.7 7575.0 7735.6 1045.2 1045.2 1056.7 1059.2 1084.5 4699.3 4793.5 4826.7 4844.9 4889.0 14134.4 14860.5 14889.1 14891.1 14893.7 13697.9 14103.9 14667.6 14711.6 14727.0 10339.1 10487.5 10529.9 10534.4 10600.3 7267.6 7603.4 7612.2 7661.3 7752.3 12791.6 12845.4 13048.7 13055.5 13089.0 10863.7 11784.8 13030.4 13094.6 13114.5 9610.3 9686.6 9790.7 9816.7 9917.9 10008.6 10035.2 10082.5 10099.2 10115.1 9169.6 9306.4 9335.2 9460.1 9537.0 8994.9 9110.2 9222.4 9431.7 9486.9 8583.5 8595.0 8610.9 8668.7 8703.5 6224.5 6289.7 6385.6 6405.9 6506.1 6353.7 6457.2 6474.0 6505.6 6719.6 12:59:07 INFO - PROCESS | 29484 | 12:59:07 INFO - PROCESS | 29484 | [#4] prototype.html Cycles:180 Average:4842.55 Median:5313.80 stddev:1286.89 (24.2%) stddev-sans-first:1247.01 12:59:07 INFO - PROCESS | 29484 | Values: 422.6 424.2 441.8 447.2 451.6 5260.8 5269.0 5273.0 5298.3 5304.9 5089.3 5149.0 5217.6 5225.2 5265.4 4439.9 4444.9 4445.7 4452.8 4455.4 4467.9 4492.6 4493.9 4499.4 4551.2 4321.3 4470.1 4489.3 4489.8 4547.7 4454.4 4460.0 4472.2 4473.6 4477.6 4191.0 4214.7 4239.6 4244.8 4264.6 4970.4 5150.5 5185.8 5251.2 5322.7 5148.6 5154.9 5171.7 5182.9 5190.9 5563.1 5595.4 5602.6 5636.6 5651.0 4334.9 4592.9 4597.2 4598.2 4702.7 5514.0 5580.6 5664.7 5727.4 5748.7 4689.4 4695.4 4700.5 4705.0 4737.7 4557.7 4632.2 4639.9 4760.1 4781.2 5069.7 5091.9 5099.7 5101.1 5103.9 5482.9 5519.9 5540.6 5544.3 5554.6 1593.9 1626.6 1655.9 1661.5 1663.6 1227.8 1249.0 1267.1 1272.7 1276.9 5425.9 5456.2 5462.9 5463.4 5514.7 5612.9 5657.4 5729.7 5762.4 5775.2 5296.5 5388.6 5414.0 5437.3 5465.6 2948.2 2979.4 2998.5 3004.0 3014.9 5624.0 5920.9 5921.5 5951.3 5957.1 5777.7 5778.3 5786.0 5792.2 5808.6 5905.3 5920.0 5946.3 5947.6 5981.5 5514.5 5593.3 5651.7 5695.2 5698.9 5387.5 5477.0 5564.7 5609.7 5635.5 5826.1 5865.9 5911.2 5953.8 5959.2 4666.4 4729.6 4731.8 4784.6 4788.1 5526.3 5665.5 5717.2 5754.4 5806.4 5520.0 5524.1 5548.8 5560.8 5567.4 5326.3 5599.6 5627.9 5629.0 5642.9 5475.2 5477.8 5483.7 5486.4 5513.4 5534.5 5554.5 5556.7 5618.3 5628.8 5206.7 5419.4 5446.5 5455.0 5478.9 12:59:07 INFO - PROCESS | 29484 | 12:59:07 INFO - PROCESS | 29484 | [#5] yui.html Cycles:180 Average:18765.65 Median:4283.06 stddev:23263.14 (543.1%) stddev-sans-first:23289.46 12:59:07 INFO - PROCESS | 29484 | Values: 841.7 891.9 892.2 937.3 945.5 15731.8 16700.0 17298.0 18022.7 18693.3 18494.2 18770.3 19160.7 19191.8 19296.7 904.6 928.8 929.2 929.4 930.2 892.9 894.5 896.5 909.6 932.2 944.6 945.1 946.1 947.4 947.5 940.8 940.8 941.0 943.8 944.2 697.4 701.5 702.0 702.4 702.9 16602.4 16656.2 16674.6 18479.0 18801.6 15580.7 15952.4 16212.4 16264.1 16512.7 13410.9 13984.7 14033.0 14052.2 14076.0 4011.5 4063.9 4091.2 4146.9 4169.0 88928.0 89373.0 90423.5 90924.5 93730.5 11954.8 12001.5 12064.8 12109.2 12461.6 21714.2 22427.1 24076.3 24089.2 24106.0 9292.6 9392.2 9455.1 9492.2 9496.8 5040.7 5107.8 5189.8 5195.1 5305.5 3786.5 3890.2 4027.8 4243.7 4322.5 686.4 693.6 694.1 702.8 710.2 637.3 638.2 640.6 668.2 839.5 11407.5 11538.5 11670.2 11941.3 12384.8 608.7 624.6 626.1 644.1 878.1 5235.5 5412.9 5531.6 5536.8 5546.6 75020.6 85860.0 86029.0 86549.6 88749.6 46718.8 48512.3 61550.7 71962.0 74166.0 62744.7 63598.4 63861.0 64021.4 64986.4 10556.3 11031.8 11196.7 11325.9 11378.4 38967.8 39950.8 43240.8 44742.0 44900.3 47848.8 48539.0 56311.0 57938.7 58702.0 12779.3 12815.7 12841.1 12887.1 13029.0 16430.5 16589.7 16734.0 16792.6 17017.7 15714.8 16052.0 16656.8 16683.2 17136.1 14670.2 15107.3 15124.4 15223.7 15833.1 14287.6 15856.8 16169.4 16498.3 16707.6 11724.7 11747.5 12361.6 12409.5 12726.8 11501.6 13060.2 13121.5 13204.7 13501.1 12:59:07 INFO - PROCESS | 29484 | -------- Summary: end -------- 12:59:07 INFO - PROCESS | 29484 | 12:59:08 INFO - TEST-INFO | 29484: exit 0 12:59:08 INFO - TEST-OK | dromaeo_css | took 1115865ms 12:59:08 INFO - TEST-START | kraken 12:59:08 INFO - operating with platform_type : linux_ 12:59:08 INFO - Initialising browser for kraken test... 12:59:08 INFO - TEST-INFO | started process 29793 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDlDGhM/profile http://localhost:44620/getInfo.html) 12:59:12 INFO - PROCESS | 29793 | __metrics Screen width/height:1600/1200 12:59:12 INFO - PROCESS | 29793 | colorDepth:24 12:59:12 INFO - PROCESS | 29793 | Browser inner width/height: 1024/697 12:59:12 INFO - PROCESS | 29793 | __metrics 12:59:13 INFO - PROCESS | 29793 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:59:13 INFO - PROCESS | 29793 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:59:14 INFO - TEST-INFO | 29793: exit 0 12:59:14 INFO - Browser initialized. 12:59:14 INFO - Running cycle 1/1 for kraken test... 12:59:14 INFO - TEST-INFO | started process 29887 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDlDGhM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:59:26 INFO - PROCESS | 29887 | RSS: Main: 141541376 12:59:26 INFO - PROCESS | 29887 | 12:59:28 INFO - PROCESS | 29887 | Cycle 1(1): loaded http://localhost:44620/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44620/tests/kraken/driver.html?testName=audio-beat-detection) 12:59:29 INFO - PROCESS | 29887 | RSS: Main: 183336960 12:59:29 INFO - PROCESS | 29887 | 12:59:31 INFO - PROCESS | 29887 | Cycle 1(1): loaded http://localhost:44620/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44620/tests/kraken/driver.html?testName=audio-dft) 12:59:32 INFO - PROCESS | 29887 | RSS: Main: 173629440 12:59:32 INFO - PROCESS | 29887 | 12:59:35 INFO - PROCESS | 29887 | Cycle 1(1): loaded http://localhost:44620/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44620/tests/kraken/driver.html?testName=audio-fft) 12:59:35 INFO - PROCESS | 29887 | RSS: Main: 265269248 12:59:35 INFO - PROCESS | 29887 | 12:59:37 INFO - PROCESS | 29887 | Cycle 1(1): loaded http://localhost:44620/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44620/tests/kraken/driver.html?testName=audio-oscillator) 12:59:38 INFO - PROCESS | 29887 | RSS: Main: 171900928 12:59:38 INFO - PROCESS | 29887 | 12:59:40 INFO - PROCESS | 29887 | Cycle 1(1): loaded http://localhost:44620/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44620/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:59:41 INFO - PROCESS | 29887 | RSS: Main: 173948928 12:59:41 INFO - PROCESS | 29887 | 12:59:44 INFO - PROCESS | 29887 | Cycle 1(1): loaded http://localhost:44620/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44620/tests/kraken/driver.html?testName=imaging-darkroom) 12:59:44 INFO - PROCESS | 29887 | RSS: Main: 212201472 12:59:44 INFO - PROCESS | 29887 | 12:59:48 INFO - PROCESS | 29887 | Cycle 1(1): loaded http://localhost:44620/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44620/tests/kraken/driver.html?testName=imaging-desaturate) 12:59:48 INFO - PROCESS | 29887 | RSS: Main: 212725760 12:59:48 INFO - PROCESS | 29887 | 12:59:51 INFO - PROCESS | 29887 | Cycle 1(1): loaded http://localhost:44620/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44620/tests/kraken/driver.html?testName=json-parse-financial) 12:59:51 INFO - PROCESS | 29887 | RSS: Main: 212164608 12:59:51 INFO - PROCESS | 29887 | 12:59:53 INFO - PROCESS | 29887 | Cycle 1(1): loaded http://localhost:44620/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44620/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:59:54 INFO - PROCESS | 29887 | RSS: Main: 174252032 12:59:54 INFO - PROCESS | 29887 | 12:59:55 INFO - PROCESS | 29887 | Cycle 1(1): loaded http://localhost:44620/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44620/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:59:56 INFO - PROCESS | 29887 | RSS: Main: 180428800 12:59:56 INFO - PROCESS | 29887 | 12:59:58 INFO - PROCESS | 29887 | Cycle 1(1): loaded http://localhost:44620/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44620/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:59:58 INFO - PROCESS | 29887 | RSS: Main: 191471616 12:59:58 INFO - PROCESS | 29887 | 13:00:01 INFO - PROCESS | 29887 | Cycle 1(1): loaded http://localhost:44620/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44620/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:00:02 INFO - PROCESS | 29887 | RSS: Main: 198909952 13:00:02 INFO - PROCESS | 29887 | 13:00:04 INFO - PROCESS | 29887 | Cycle 1(1): loaded http://localhost:44620/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44620/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:00:05 INFO - PROCESS | 29887 | RSS: Main: 195346432 13:00:05 INFO - PROCESS | 29887 | 13:00:07 INFO - PROCESS | 29887 | Cycle 1(1): loaded http://localhost:44620/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44620/tests/kraken/driver.html?testName=ai-astar) 13:00:07 INFO - PROCESS | 29887 | RSS: Main: 246460416 13:00:07 INFO - PROCESS | 29887 | 13:00:07 INFO - PROCESS | 29887 | __start_tp_report 13:00:07 INFO - PROCESS | 29887 | _x_x_mozilla_page_load 13:00:07 INFO - PROCESS | 29887 | _x_x_mozilla_page_load_details 13:00:07 INFO - PROCESS | 29887 | |i|pagename|runs| 13:00:07 INFO - PROCESS | 29887 | |0;ai-astar;102;112;113;112;112;112;111;114;111;111 13:00:07 INFO - PROCESS | 29887 | |1;audio-beat-detection;141;117;121;165;116;116;117;116;134;117 13:00:07 INFO - PROCESS | 29887 | |2;audio-dft;162;161;160;162;161;160;160;161;160;161 13:00:07 INFO - PROCESS | 29887 | |3;audio-fft;73;75;74;108;75;75;75;76;90;75 13:00:07 INFO - PROCESS | 29887 | |4;audio-oscillator;81;82;105;81;82;82;101;82;82;109 13:00:07 INFO - PROCESS | 29887 | |5;imaging-gaussian-blur;113;113;113;113;112;112;112;113;113;113 13:00:07 INFO - PROCESS | 29887 | |6;imaging-darkroom;147;146;146;147;147;146;145;146;146;147 13:00:07 INFO - PROCESS | 29887 | |7;imaging-desaturate;94;94;95;94;94;93;94;94;94;93 13:00:07 INFO - PROCESS | 29887 | |8;json-parse-financial;57;54;55;54;55;55;58;56;53;56 13:00:07 INFO - PROCESS | 29887 | |9;json-stringify-tinderbox;52;52;53;52;52;53;55;53;53;52 13:00:07 INFO - PROCESS | 29887 | |10;stanford-crypto-aes;76;75;79;85;76;79;76;80;83;75 13:00:07 INFO - PROCESS | 29887 | |11;stanford-crypto-ccm;126;128;120;124;120;119;118;119;167;120 13:00:07 INFO - PROCESS | 29887 | |12;stanford-crypto-pbkdf2;161;161;159;163;164;165;160;157;158;163 13:00:07 INFO - PROCESS | 29887 | |13;stanford-crypto-sha256-iterative;65;59;60;60;60;58;60;62;60;58 13:00:07 INFO - PROCESS | 29887 | __end_tp_report 13:00:07 INFO - PROCESS | 29887 | __start_cc_report 13:00:07 INFO - PROCESS | 29887 | _x_x_mozilla_cycle_collect,1638 13:00:07 INFO - PROCESS | 29887 | __end_cc_report 13:00:07 INFO - PROCESS | 29887 | __startTimestamp1496174407340__endTimestamp 13:00:07 INFO - PROCESS | 29887 | 13:00:07 INFO - PROCESS | 29887 | ------- Summary: start ------- 13:00:07 INFO - PROCESS | 29887 | Number of tests: 14 13:00:07 INFO - PROCESS | 29887 | 13:00:07 INFO - PROCESS | 29887 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:3.30 (2.9%) stddev-sans-first:1.00 13:00:07 INFO - PROCESS | 29887 | Values: 102.0 112.0 113.0 112.0 112.0 112.0 111.0 114.0 111.0 111.0 13:00:07 INFO - PROCESS | 29887 | 13:00:07 INFO - PROCESS | 29887 | [#1] audio-beat-detection Cycles:10 Average:126.00 Median:119.00 stddev:16.25 (13.7%) stddev-sans-first:16.31 13:00:07 INFO - PROCESS | 29887 | Values: 141.0 117.0 121.0 165.0 116.0 116.0 117.0 116.0 134.0 117.0 13:00:07 INFO - PROCESS | 29887 | 13:00:07 INFO - PROCESS | 29887 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 13:00:07 INFO - PROCESS | 29887 | Values: 162.0 161.0 160.0 162.0 161.0 160.0 160.0 161.0 160.0 161.0 13:00:07 INFO - PROCESS | 29887 | 13:00:07 INFO - PROCESS | 29887 | [#3] audio-fft Cycles:10 Average:79.60 Median:75.00 stddev:11.10 (14.8%) stddev-sans-first:11.51 13:00:07 INFO - PROCESS | 29887 | Values: 73.0 75.0 74.0 108.0 75.0 75.0 75.0 76.0 90.0 75.0 13:00:07 INFO - PROCESS | 29887 | 13:00:07 INFO - PROCESS | 29887 | [#4] audio-oscillator Cycles:10 Average:88.70 Median:82.00 stddev:11.41 (13.9%) stddev-sans-first:11.76 13:00:07 INFO - PROCESS | 29887 | Values: 81.0 82.0 105.0 81.0 82.0 82.0 101.0 82.0 82.0 109.0 13:00:07 INFO - PROCESS | 29887 | 13:00:07 INFO - PROCESS | 29887 | [#5] imaging-gaussian-blur Cycles:10 Average:112.70 Median:113.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 13:00:07 INFO - PROCESS | 29887 | Values: 113.0 113.0 113.0 113.0 112.0 112.0 112.0 113.0 113.0 113.0 13:00:07 INFO - PROCESS | 29887 | 13:00:07 INFO - PROCESS | 29887 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.67 (0.5%) stddev-sans-first:0.67 13:00:07 INFO - PROCESS | 29887 | Values: 147.0 146.0 146.0 147.0 147.0 146.0 145.0 146.0 146.0 147.0 13:00:07 INFO - PROCESS | 29887 | 13:00:07 INFO - PROCESS | 29887 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 13:00:07 INFO - PROCESS | 29887 | Values: 94.0 94.0 95.0 94.0 94.0 93.0 94.0 94.0 94.0 93.0 13:00:07 INFO - PROCESS | 29887 | 13:00:07 INFO - PROCESS | 29887 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.50 stddev:1.49 (2.7%) stddev-sans-first:1.45 13:00:07 INFO - PROCESS | 29887 | Values: 57.0 54.0 55.0 54.0 55.0 55.0 58.0 56.0 53.0 56.0 13:00:07 INFO - PROCESS | 29887 | 13:00:07 INFO - PROCESS | 29887 | [#9] json-stringify-tinderbox Cycles:10 Average:52.70 Median:53.00 stddev:0.95 (1.8%) stddev-sans-first:0.97 13:00:07 INFO - PROCESS | 29887 | Values: 52.0 52.0 53.0 52.0 52.0 53.0 55.0 53.0 53.0 52.0 13:00:07 INFO - PROCESS | 29887 | 13:00:07 INFO - PROCESS | 29887 | [#10] stanford-crypto-aes Cycles:10 Average:78.40 Median:79.00 stddev:3.47 (4.4%) stddev-sans-first:3.57 13:00:07 INFO - PROCESS | 29887 | Values: 76.0 75.0 79.0 85.0 76.0 79.0 76.0 80.0 83.0 75.0 13:00:07 INFO - PROCESS | 29887 | 13:00:07 INFO - PROCESS | 29887 | [#11] stanford-crypto-ccm Cycles:10 Average:126.10 Median:122.00 stddev:14.75 (12.1%) stddev-sans-first:15.65 13:00:07 INFO - PROCESS | 29887 | Values: 126.0 128.0 120.0 124.0 120.0 119.0 118.0 119.0 167.0 120.0 13:00:07 INFO - PROCESS | 29887 | 13:00:07 INFO - PROCESS | 29887 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.10 Median:162.00 stddev:2.64 (1.6%) stddev-sans-first:2.80 13:00:07 INFO - PROCESS | 29887 | Values: 161.0 161.0 159.0 163.0 164.0 165.0 160.0 157.0 158.0 163.0 13:00:07 INFO - PROCESS | 29887 | 13:00:07 INFO - PROCESS | 29887 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.20 Median:60.00 stddev:2.04 (3.4%) stddev-sans-first:1.22 13:00:07 INFO - PROCESS | 29887 | Values: 65.0 59.0 60.0 60.0 60.0 58.0 60.0 62.0 60.0 58.0 13:00:07 INFO - PROCESS | 29887 | -------- Summary: end -------- 13:00:07 INFO - PROCESS | 29887 | 13:00:08 INFO - TEST-INFO | 29887: exit 0 13:00:08 INFO - TEST-OK | kraken | took 60152ms 13:00:08 INFO - SUITE-END | took 1176s 13:00:08 INFO - Completed test suite (00:19:36) 13:00:08 INFO - javascript benchmark 13:00:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7877.392812642883, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3376.6960973512387, 3399.9830000849993, 3460.100373902786, 3466.7746596471243, 3499.685028347448, 5673.659580425177, 5749.59752817303, 5766.221560089392, 5770.884582308351, 5774.451427114417, 5721.284839395075, 5791.362950075489, 5792.986227410207, 5798.0, 5806.158107074471, 5224.738763061841, 5234.869128271805, 5274.683518988873, 5275.393329767068, 5320.441353657869, 5070.771815268322, 5124.513171248744, 5298.841034768944, 5318.574514038867, 5320.255164277004, 5173.896522069556, 5183.481651834824, 5197.402298735656, 5212.687238765668, 5221.530062294392, 5296.020236256305, 5296.655717378358, 5300.31095957523, 5304.151335786294, 5316.73416329182, 5061.342025536656, 5160.458151894035, 5226.111561034633, 5272.499112584298, 5279.260903473517, 5612.270404847384, 5621.80323688673, 5635.830925072254, 5682.147677848315, 5690.9146362804595, 6103.267607887082, 6138.815835524942, 6145.78489752861, 6157.661328626924, 6161.353057928898, 6166.660833654148, 6167.969160154171, 6176.320604733476, 6186.628802271833, 6188.381161883775, 5526.419725928759, 5561.193626924114, 5680.5171560417, 5717.371089180187, 5718.571107166979, 6259.561830671809, 6276.0, 6280.717367718464, 6281.214848143982, 6281.59169653971, 5983.309558483666, 6037.72830222641, 6052.394760523913, 6053.939460605426, 6055.757769689163, 5912.9113063304085, 5978.910316345258, 6066.302375226817, 6108.450239478379, 6134.570580059442, 6127.017204504704, 6135.8334873451895, 6135.875804921915, 6136.097809679014, 6142.262928448615, 5922.970385148046, 5940.34656187819, 5951.345352011275, 5958.523318134626, 6144.003198960356, 4582.152301824173, 4639.930401043919, 4642.442906851199, 4644.95355046452, 4684.016356565091, 4201.789910504463, 4210.242156411875, 4221.345691417835, 4238.067625122468, 4241.936370954438, 5720.227769251181, 5738.626989245686, 5913.319968203712, 5920.615160014585, 5920.644761314335, 6161.045038019114, 6165.32181460039, 6191.907121393183, 6196.287426945959, 6197.4732147767945, 5906.527477801766, 5915.231019967377, 5921.763129474859, 5925.05199168131, 5939.940600594025, 5077.796888124433, 5101.2603172539775, 5232.659877107976, 5256.526912577886, 5261.421243663194, 6343.619382837044, 6375.553711240169, 6378.585391949508, 6427.3251308611925, 6456.9354306456335, 6082.0, 6131.570790044832, 6136.693165341626, 6137.60105593135, 6173.969130154321, 6359.777407790705, 6442.09810626522, 6446.580972236789, 6447.806565803034, 6450.741970321323, 5844.824655260349, 5854.443827836349, 5974.014287642491, 5981.581289309706, 6011.609245399035, 6171.074338849029, 6176.6911654418, 6180.072989051679, 6185.597936134317, 6193.411625895533, 5993.520518358434, 6025.8192254232445, 6050.606710563799, 6053.552956154918, 6061.696915154313, 5734.369219385948, 5759.0, 5960.612560183574, 5967.6419414835245, 6045.818625441244, 6012.759489620541, 6013.398660133952, 6028.457438830526, 6042.728077236623, 6052.122442245938, 5852.385499522489, 5876.118582212703, 6062.242219722535, 6062.6665533394325, 6069.848253793691, 5800.1299805029585, 5860.619059761102, 5877.706114694333, 5882.941170588239, 5891.793787217427], "value": 5659.087188575217, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [785.1638005524117, 836.4103307168447, 861.8577934640787, 909.3316412436853, 919.5402298850574, 32337.0, 34537.30925381491, 34546.65453345466, 43575.56424435755, 44004.33993490092, 45634.543654563444, 45805.0, 45988.31017534732, 46039.0, 46144.538554614446, 8970.910290897073, 9133.862992055125, 9140.131687489678, 9140.542972851365, 9148.451092934412, 7598.772036838904, 7733.613319334039, 8946.597403116875, 10537.73655658611, 10841.728956776065, 10821.729456763565, 10846.0, 10878.347299162037, 10880.891191088107, 10886.40124793136, 10793.514291856885, 10794.5682172713, 10814.35113893165, 10815.134789216843, 10828.350298982046, 10595.311304765242, 10626.946865265701, 10633.57465701371, 10647.0, 10654.786904261871, 42457.78771106156, 42661.786691066656, 42850.35724464135, 42913.57086429127, 43059.13881722379, 4294.463192100988, 4345.435093437833, 4388.780560971971, 4466.0, 4484.753338566377, 30659.693403065907, 30917.0724878254, 31053.84473077643, 31286.53070203926, 32064.19839504008, 3970.980145099256, 3995.6603688686496, 4020.2361551305157, 4042.6765858731233, 4092.631663150331, 224064.0, 224328.0, 224494.0, 224932.87533562392, 226347.0, 53083.469165307855, 53204.46795531995, 53216.0, 53264.46735532595, 53314.0, 55882.0, 56046.15930761042, 56082.71958640181, 56106.0, 56274.43725562774, 15907.125108119164, 16319.265633046542, 16360.10019448918, 16372.836271637369, 16385.09881956504, 14420.134791912518, 14431.855681443261, 14434.350454229585, 14456.638584035272, 14475.203863787383, 11306.265092768943, 11501.597444089417, 11822.0, 13088.803667944989, 13148.737025259632, 5427.620066595379, 5520.666276972557, 5532.2531458253425, 5538.833834984957, 5576.33084029919, 1017.704865588971, 1021.8722659667542, 1033.565902321027, 1043.6451606453843, 1060.157175045825, 27518.44963100767, 28010.71989280122, 28149.57775633367, 28344.574831377548, 28489.71510284912, 1088.580896354909, 1104.536094840169, 1105.950232239551, 1117.402189828438, 1121.6354684727332, 14293.356798944073, 15104.54686359411, 15157.393704251926, 15214.315355809014, 15334.616634584225, 296820.0, 297359.0, 297861.0, 297893.0, 298000.0, 55596.722016389656, 55686.72156639191, 55734.44265557374, 55746.442535574126, 55806.44193558012, 1478.090974050951, 1480.9259537023322, 1509.8641122299045, 1521.7108749337813, 1567.7569976653408, 27675.86162069177, 27885.58171627468, 28580.714192857806, 28917.56623650605, 29237.561436578042, 36534.269314613026, 36573.817130914176, 36698.63301367059, 36758.63241367659, 36771.63228367682, 282166.0, 283226.0, 283242.0, 283610.0, 284400.0, 26933.0, 27491.587626186025, 27731.306717332227, 30403.0, 30475.2381190472, 32397.35205295928, 32635.673643264214, 32669.836650816593, 33650.49524257187, 36413.817930910176, 25261.368465788502, 31439.0, 31458.842705786323, 31467.685323146474, 31847.68152318447, 31142.0, 31148.22129446782, 31557.8422107888, 31695.52456713197, 31858.20354491156, 35525.0, 35529.822350888084, 35663.46504802482, 35774.642253577134, 36546.26907461783, 30166.245843854078, 30194.849025755608, 30287.697123028487, 30430.54354184733, 30745.0, 23814.523709525365, 24896.62655060212, 24930.252092437255, 25016.749832501442, 25163.87418062898], "value": 18405.19479925618, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [459.7310573314611, 473.176672589694, 482.2115840600619, 483.26784920844915, 491.2214140587169, 20028.399148025546, 21827.126914923403, 22470.66294005591, 22576.43558911026, 22720.43198920028, 22696.0, 22731.0, 23053.308400748003, 23214.65178022331, 23226.535469290604, 6638.203415590136, 6755.628440435762, 6825.078614387068, 6858.3141685831515, 6863.828404289908, 6720.663966801665, 6886.793396198122, 7200.459965502609, 7497.0, 7541.396688264953, 7322.963385183067, 7523.172451030382, 7526.397888168934, 7535.20880307568, 7536.095668519785, 7463.402927765793, 7657.808554786119, 7663.386929045663, 7703.614819259014, 7707.383409327241, 7238.855222895512, 7439.4792364534505, 7471.327580517725, 7482.251774822528, 7490.588017659026, 24726.629100563507, 25135.0, 25450.49099018028, 26347.868260658764, 26725.73274267252, 3488.4592888102384, 3559.2169722660974, 3583.8566457341676, 3597.6402359764074, 3616.7287453440836, 16399.0, 16502.75245871313, 16653.16734163287, 16662.50012499627, 16711.66576668472, 2322.5354929014097, 2392.4497365606007, 2393.5452264069772, 2399.484110916144, 2451.0563433078214, 111182.44408777905, 115258.48929312095, 117045.41477292644, 121769.0, 124012.37993809974, 17853.196606152494, 18054.638907221783, 18187.63624727498, 18198.5450363742, 18571.16429760664, 32377.19057023546, 32465.51301730476, 32477.0, 32504.837475812943, 32803.34393312121, 10557.47212639365, 10626.14990800734, 10663.146948244123, 10709.196810239264, 10860.891391085988, 9042.140996605312, 9072.138146876036, 9119.635214591475, 9256.768580785534, 9289.62841486333, 9037.141471560191, 9357.0, 9407.153356197976, 9430.245580353556, 9694.563744631367, 3432.2667053138007, 3475.4786781982907, 3561.821908904596, 3641.1807343347537, 3787.50442990273, 958.836997710391, 967.7967626798311, 972.3242346569067, 974.1914211204684, 982.2093214961882, 20041.899790500953, 20790.58418831615, 21221.469463263235, 21390.572188556143, 21666.89166554157, 982.8083374075851, 988.7231575158967, 994.3195998762069, 999.7000899730198, 1014.1531820929606, 11209.21535492524, 11669.416529173508, 11736.119791015537, 11763.176577639655, 11907.404629768476, 666630.0, 668397.0, 676267.0, 682029.0, 683374.0, 88022.0, 111774.44112779383, 114787.0, 115441.0, 117108.41445792717, 1229.8647148813623, 1248.6129299917054, 1272.2557303977092, 1279.0215485153865, 1281.8397700287464, 18052.909735451238, 18393.632127357647, 18481.53796155107, 18534.0, 18933.148008339933, 52237.0, 53218.46781532135, 53228.0, 53558.0, 54001.0, 70190.64904675444, 70340.94488582572, 70630.0, 71284.0, 71488.0, 11311.830322545004, 12773.552925647558, 12899.548515801902, 12900.935495322463, 12957.740845183233, 13471.46114155462, 13709.725805484033, 13763.724725505634, 14734.189619571027, 14766.77849832232, 7360.815979600553, 12338.81491777606, 12497.18768280059, 12846.550370736979, 12974.805377919527, 11981.880181198425, 12012.699682508008, 12048.75902481928, 12060.51757929673, 12296.446659900505, 12528.436220369922, 12580.119391642496, 12600.306983116017, 12735.872641273469, 12805.231686098863, 12541.435635396612, 12577.559785407833, 12693.301868397326, 12695.55565555201, 13065.608031759062, 12418.503259869503, 12495.437705303102, 12559.372031398576, 12992.935035325141, 13212.273324967218], "value": 11743.894841482761, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1401.2923473645808, 1552.44888064737, 1553.2311505804626, 1569.7741141953288, 1575.2045217165332, 9332.813343733122, 10868.728281792959, 11231.66305010851, 11257.60598379056, 11262.887371126286, 11383.0, 11443.313401195934, 11454.541818327258, 11464.656060318182, 11465.770684586303, 2084.843636727244, 2134.50906291553, 2488.054539275073, 2526.987365063172, 2529.6458495810602, 2483.7019557653107, 2563.102913980101, 2571.1386685460393, 2572.498362819251, 2573.4338445541953, 2496.2261698873317, 2519.60946053362, 2526.0, 2528.911488097917, 2532.3669082729316, 2477.046337160188, 2500.2874180858457, 2508.147229941819, 2508.385445565839, 2520.785733212679, 2364.054378248697, 2377.667126602277, 2396.9041238350446, 2398.280515845257, 2402.483466054789, 11264.718382040433, 11447.771044579145, 11454.48454819535, 11469.827952580634, 11481.540738370455, 5877.235959325303, 6011.0, 6020.0, 6021.759129634809, 6023.397660233985, 3480.617132115465, 3508.5263489428858, 3557.0, 3628.8004159771203, 3679.963200367989, 1345.7173993461386, 1353.0, 1354.356680576728, 1406.2265753835452, 1427.3933578229314, 16663.6667266654, 16797.244124014327, 16903.915480422642, 16914.492565223063, 16973.405930792364, 4888.413390393175, 4927.926081108786, 4956.925646115311, 5097.209932460474, 5199.636025478256, 13870.930645346709, 13947.093438926437, 13949.302534873215, 13958.0, 13964.790528142086, 6037.335893051761, 6044.304904935901, 6062.575619706667, 6065.636061836304, 6072.967595508774, 5448.42791506894, 5533.170024496358, 5649.858753531194, 5689.800856969986, 5699.857503562444, 4185.727927684691, 4272.786360681954, 4280.13813990915, 4327.913441731148, 4338.305871060678, 1168.6318809575127, 1189.1616410430627, 1197.0722689915385, 1205.1624121235832, 1206.7827790997706, 1034.6171916390983, 1044.2064031336088, 1053.773438710681, 1057.6774083904484, 1058.85705429766, 7241.0, 7500.924990750132, 7531.661075251627, 7575.0, 7735.613219339123, 1045.153425725165, 1045.1586472889246, 1056.7199692081604, 1059.2373491086405, 1084.511969613677, 4699.318598803155, 4793.520647935178, 4826.734529600905, 4844.878878028077, 4888.9755551222015, 14134.36395362211, 14860.479883204036, 14889.106653600818, 14891.106533608017, 14893.70212595742, 13697.863021369858, 14103.85896141046, 14667.559973200821, 14711.632209194642, 14727.0, 10339.0694837465, 10487.475626218658, 10529.947350263354, 10534.420606866695, 10600.310979786289, 7267.563946163035, 7603.353714934293, 7612.162662107053, 7661.348785353307, 7752.341051010727, 12791.616251512469, 12845.35773211317, 13048.673783155118, 13055.543055992996, 13089.0, 10863.728406789893, 11784.764304713686, 13030.41363138642, 13094.607161785161, 13114.475420983053, 9610.279229057709, 9686.612535498502, 9790.706278811647, 9816.705498835046, 9917.851232231667, 10008.599656013677, 10035.19718422539, 10082.546285417027, 10099.192064634664, 10115.140213081677, 9169.633214671605, 9306.395084319498, 9335.159835614828, 9460.053994600485, 9536.952315238379, 8994.86507702398, 9110.180083792491, 9222.44665320083, 9431.717048488556, 9486.905130948602, 8583.484990900566, 8594.957025215084, 8610.870836937325, 8668.653253870027, 8703.477791332287, 6224.502039836711, 6289.7484100635465, 6385.584936979081, 6405.8718825624155, 6506.056621789909, 6353.745850166127, 6457.160569125984, 6473.967630161819, 6505.60966342002, 6719.563228390139], "value": 5478.012234754757, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [422.640755357946, 424.2321398269133, 441.77690266415476, 447.16157205240177, 451.56649616368287, 5260.842174734755, 5268.973655131728, 5273.018870752581, 5298.258243845855, 5304.946950530493, 5089.2620570017325, 5149.0, 5217.582593392529, 5225.190095535198, 5265.420803711589, 4439.866803995869, 4444.933326000112, 4445.733256004634, 4452.8441504547345, 4455.443069616298, 4467.865964021084, 4492.550744925514, 4493.932591011137, 4499.370088187657, 4551.180787458256, 4321.314687271966, 4470.100207411853, 4489.2817149256125, 4489.775511224442, 4547.727136371828, 4454.420925279725, 4459.951911300842, 4472.217361961676, 4473.552644735533, 4477.582105662938, 4190.958090419118, 4214.73557932622, 4239.576042395766, 4244.808983595745, 4264.594863487995, 4970.428400733926, 5150.484951504857, 5185.818496352647, 5251.186066159751, 5322.654027488201, 5148.5623721983675, 5154.871128221787, 5171.715555644438, 5182.948170518284, 5190.948090519084, 5563.054280772238, 5595.412481689405, 5602.579806514527, 5636.605437619368, 5650.971745141289, 4334.869953901388, 4592.88517787058, 4597.195490789099, 4598.241290187115, 4702.670813043088, 5513.972430137824, 5580.637258578179, 5664.745086471077, 5727.3699893011735, 5748.683822389767, 4689.390379250675, 4695.413073365829, 4700.482946875841, 4704.976475117671, 4737.668363214542, 4557.680962332671, 4632.189366860786, 4639.907201855944, 4760.09558183944, 4781.163296423112, 5069.721165335942, 5091.949080509222, 5099.719515426687, 5101.138084599094, 5103.902660927844, 5482.91775623366, 5519.944800551943, 5540.63985840919, 5544.251526044013, 5554.611517047709, 1593.9043657380594, 1626.6336277526934, 1655.9420420285232, 1661.5264649574813, 1663.5924198571427, 1227.8281040654315, 1248.9875101249054, 1267.0560432477862, 1272.7272727272727, 1276.869970076489, 5425.941941321484, 5456.181572764038, 5462.945370546323, 5463.399026107125, 5514.696691681916, 5612.943870561324, 5657.405972372924, 5729.742161602738, 5762.423757624204, 5775.220345253421, 5296.549793267615, 5388.602072077966, 5414.0, 5437.32033495813, 5465.6447330923365, 2948.248196709825, 2979.4339075576004, 2998.4752668282963, 3003.9549406758915, 3014.8643311051055, 5623.959567480029, 5920.881582368328, 5921.496672782861, 5951.315598706117, 5957.076653118774, 5777.711114444261, 5778.306603207558, 5785.971070144622, 5792.247007889032, 5808.6224395414165, 5905.320888097752, 5919.970400147971, 5946.256717910262, 5947.6431414115295, 5981.491573216325, 5514.476124768141, 5593.349961761209, 5651.745671444877, 5695.231143795535, 5698.886022279448, 5387.461253874581, 5476.972615136899, 5564.690653378802, 5609.691466969356, 5635.549156067423, 5826.067829147316, 5865.912011319749, 5911.172435859069, 5953.821385358447, 5959.22530071088, 4666.393368862026, 4729.574338309569, 4731.810727570859, 4784.593309568587, 4788.11419887322, 5526.281583394133, 5665.518430933417, 5717.1995920570325, 5754.3670196277535, 5806.44838740319, 5519.957615682223, 5524.14375771756, 5548.778048878, 5560.7756897241425, 5567.359753628222, 5326.25432439451, 5599.60802743804, 5627.943720562906, 5629.0, 5642.85892852682, 5475.206095116266, 5477.75350109238, 5483.670979741229, 5486.423925487767, 5513.365962914316, 5534.505683465522, 5554.50009499147, 5556.666600004012, 5618.297712785902, 5628.831135065954, 5206.687598744087, 5419.376771671308, 5446.482584154499, 5455.0, 5478.945210547843], "value": 4470.502376063017, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [841.7264389073553, 891.8662200669903, 892.2371372476529, 937.2567025332881, 945.5225111318781, 15731.764023539641, 16699.998000120002, 17298.0, 18022.729659055123, 18693.34573289935, 18494.16776245069, 18770.34303799364, 19160.712589311137, 19191.80808191921, 19296.71054934177, 904.5703290936818, 928.7538802217417, 929.2008872369756, 929.4098247612746, 930.1582068228264, 892.9330300227476, 894.5259012723267, 896.4621227263623, 909.56340956341, 932.2169377722712, 944.6363150187193, 945.0502245243521, 946.1153821177221, 947.3652652722658, 947.5357075033219, 940.7742141885932, 940.8212439636447, 940.9670661526848, 943.8253923024229, 944.1927152284835, 697.3758486154863, 701.4984286235366, 702.0311969482133, 702.3608516250239, 702.8805103132429, 16602.418915338025, 16656.167191640492, 16674.58313542159, 18479.0, 18801.623967520572, 15580.688386232325, 15952.4416645418, 16212.351505939749, 16264.105474198914, 16512.669746605, 13410.865891341156, 13984.650383740387, 14033.0, 14052.156870587798, 14076.0, 4011.5186177658575, 4063.878083657495, 4091.2226676931286, 4146.854860079883, 4168.958310416887, 88928.0, 89373.0, 90423.54788226083, 90924.54537727269, 93730.53134734283, 11954.760904781855, 12001.459934302977, 12064.819027714591, 12109.212901161396, 12461.626151215478, 21714.24000159987, 22427.102915883508, 24076.277711668678, 24089.156879509133, 24106.0, 9292.628294868266, 9392.201662858597, 9455.14903658674, 9492.240620750461, 9496.762580935532, 5040.722760248222, 5107.770150343244, 5189.818356357509, 5195.11683013881, 5305.495977882095, 3786.4888240087234, 3890.183061557105, 4027.838886444568, 4243.6605071594195, 4322.459692538433, 686.3856848120904, 693.6081114170478, 694.1011390249639, 702.8242939265184, 710.1761956130863, 637.3499030988365, 638.1894993358409, 640.5644161969813, 668.2081733146238, 839.4837175137246, 11407.48666310018, 11538.538458461568, 11670.241434306743, 11941.283522988648, 12384.81422778659, 608.716946619824, 624.5752888036179, 626.064034268762, 644.1497223664718, 878.1438097854668, 5235.502627250406, 5412.945870541244, 5531.612787104945, 5536.833894983157, 5546.639468434539, 75020.62489687625, 85860.0, 86029.0, 86549.56725216334, 88749.55625221833, 46718.76640616843, 48512.27231591529, 61550.69224653848, 71962.0, 74166.0, 62744.686276568325, 63598.36401636017, 63861.0, 64021.35978640247, 64986.35013649898, 10556.313839600401, 11031.83452248233, 11196.712378076625, 11325.943370283096, 11378.37418941933, 38967.805160974014, 39950.80024599859, 43240.783796082076, 44742.0, 44900.326495101945, 47848.760756197385, 48539.02921941612, 56311.0, 57938.7103064482, 58702.0, 12779.297138657463, 12815.743685126059, 12841.10112292168, 12887.097903147065, 13029.022823288102, 16430.507084787474, 16589.66820663604, 16734.0, 16792.58018549546, 17017.659646806747, 15714.76427853606, 16052.0, 16656.833431665527, 16683.249253783368, 17136.14319284056, 14670.193139377438, 15107.32017059213, 15124.39502419891, 15223.695526089195, 15833.129177895325, 14287.57137285883, 15856.841431585537, 16169.353225870833, 16498.25757840924, 16707.582310442336, 11724.70688232801, 11747.530098795953, 12361.62915112548, 12409.503619855104, 12726.809097863725, 11501.597444089417, 13060.21638701681, 13121.475140994253, 13204.669883252996, 13501.122427042212], "value": 7975.893253536805, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1452.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 113.0, 112.0, 112.0, 112.0, 111.0, 114.0, 111.0, 111.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 117.0, 121.0, 165.0, 116.0, 116.0, 117.0, 116.0, 134.0, 117.0], "value": 126.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 162.0, 161.0, 160.0, 160.0, 161.0, 160.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 74.0, 108.0, 75.0, 75.0, 75.0, 76.0, 90.0, 75.0], "value": 79.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 105.0, 81.0, 82.0, 82.0, 101.0, 82.0, 82.0, 109.0], "value": 88.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 113.0, 112.0, 112.0, 112.0, 113.0, 113.0, 113.0], "value": 112.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 145.0, 146.0, 146.0, 147.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 93.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 55.0, 54.0, 55.0, 55.0, 58.0, 56.0, 53.0, 56.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 53.0, 52.0, 52.0, 53.0, 55.0, 53.0, 53.0, 52.0], "value": 52.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 79.0, 85.0, 76.0, 79.0, 76.0, 80.0, 83.0, 75.0], "value": 78.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 128.0, 120.0, 124.0, 120.0, 119.0, 118.0, 119.0, 167.0, 120.0], "value": 126.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 159.0, 163.0, 164.0, 165.0, 160.0, 157.0, 158.0, 163.0], "value": 161.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 59.0, 60.0, 60.0, 60.0, 58.0, 60.0, 62.0, 60.0, 58.0], "value": 60.2, "unit": "score"}]}]} 13:00:08 INFO - Return code: 0 13:00:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:00:08 INFO - # TBPL SUCCESS # 13:00:08 INFO - Running post-action listener: _resource_record_post_action 13:00:08 INFO - [mozharness: 2017-05-30 20:00:08.667383Z] Finished run-tests step (success) 13:00:08 INFO - Running post-run listener: _resource_record_post_run 13:00:08 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 77824; Write bytes: 325373952; Read time: 188; Write time: 214488 13:00:08 INFO - TinderboxPrint: CPU usage
13.1% 13:00:08 INFO - TinderboxPrint: I/O read bytes / time
77,824 / 188 13:00:08 INFO - TinderboxPrint: I/O write bytes / time
325,373,952 / 214,488 13:00:08 INFO - TinderboxPrint: CPU idle
8,251.6 (86.9%) 13:00:08 INFO - TinderboxPrint: CPU user
1,200.3 (12.6%) 13:00:08 INFO - TinderboxPrint: Swap in / out
0 / 0 13:00:08 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 479232; Read time: 0; Write time: 56 13:00:08 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 73728; Write bytes: 253345792; Read time: 4; Write time: 175812 13:00:09 INFO - Running post-run listener: _upload_blobber_files 13:00:09 INFO - Blob upload gear active. 13:00:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:00:09 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 13:00:09 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', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:00:09 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 Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:00:09 INFO - (blobuploader) - INFO - Open directory for files ... 13:00:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:00:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:00:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:00:10 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:00:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:00:10 INFO - (blobuploader) - INFO - Done attempting. 13:00:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:00:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:00:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:00:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:00:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:00:17 INFO - (blobuploader) - INFO - Done attempting. 13:00:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:00:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:00:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:00:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:00:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:00:18 INFO - (blobuploader) - INFO - Done attempting. 13:00:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:00:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:00:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:00:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:00:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:00:19 INFO - (blobuploader) - INFO - Done attempting. 13:00:19 INFO - (blobuploader) - INFO - Iteration through files over. 13:00:19 INFO - Return code: 0 13:00:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:00:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:00:19 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/301fabb380a1bb0d52089ba789cdfde80285707df61a3e58e851b9f63fde82e33d43fa4a411b23ade05405d24a7c2c67eb748152cef925c5499e556759dd45d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d069ccca9b606a2a721880c05a961418ac107a1754bf369be130dc71b64261264937a334dcc40b5ed3672d926375ad0c771081748c56b8e55b3c92e345353d82", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/579b3024259de75f300978137eb3510109a79e083f5192a39766e5d1207884024c3bf64babe37298e8cf98b467cd2328b83b37d71bbc503dad0671e6ec3f1d22", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/be64e4657dfb830a919fa842ff70066205d7e034c1e58130bd8beef2976f8bc18bfa2566f9887e548de79ae43011015afb8b047fa1a82e04e14a7a32233d2f2f"} 13:00:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:00:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:00:19 INFO - Contents: 13:00:19 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/301fabb380a1bb0d52089ba789cdfde80285707df61a3e58e851b9f63fde82e33d43fa4a411b23ade05405d24a7c2c67eb748152cef925c5499e556759dd45d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d069ccca9b606a2a721880c05a961418ac107a1754bf369be130dc71b64261264937a334dcc40b5ed3672d926375ad0c771081748c56b8e55b3c92e345353d82", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/579b3024259de75f300978137eb3510109a79e083f5192a39766e5d1207884024c3bf64babe37298e8cf98b467cd2328b83b37d71bbc503dad0671e6ec3f1d22", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/be64e4657dfb830a919fa842ff70066205d7e034c1e58130bd8beef2976f8bc18bfa2566f9887e548de79ae43011015afb8b047fa1a82e04e14a7a32233d2f2f"} 13:00:19 INFO - Running post-run listener: copy_logs_to_upload_dir 13:00:19 INFO - Copying logs to upload dir... 13:00:19 INFO - mkdir: /builds/slave/test/build/upload/logs 13:00:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.730453 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-05-30 13:00:19.079913) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-30 13:00:19.083589) ========= 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=d2a8c569965ab8367867b893000001a1-1496171467.168564-1124926776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/301fabb380a1bb0d52089ba789cdfde80285707df61a3e58e851b9f63fde82e33d43fa4a411b23ade05405d24a7c2c67eb748152cef925c5499e556759dd45d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d069ccca9b606a2a721880c05a961418ac107a1754bf369be130dc71b64261264937a334dcc40b5ed3672d926375ad0c771081748c56b8e55b3c92e345353d82", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/579b3024259de75f300978137eb3510109a79e083f5192a39766e5d1207884024c3bf64babe37298e8cf98b467cd2328b83b37d71bbc503dad0671e6ec3f1d22", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/be64e4657dfb830a919fa842ff70066205d7e034c1e58130bd8beef2976f8bc18bfa2566f9887e548de79ae43011015afb8b047fa1a82e04e14a7a32233d2f2f"} build_url:https://queue.taskcluster.net/v1/task/GwP3vRZZRVuz-R5itW5BeQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011309 build_url: 'https://queue.taskcluster.net/v1/task/GwP3vRZZRVuz-R5itW5BeQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/301fabb380a1bb0d52089ba789cdfde80285707df61a3e58e851b9f63fde82e33d43fa4a411b23ade05405d24a7c2c67eb748152cef925c5499e556759dd45d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d069ccca9b606a2a721880c05a961418ac107a1754bf369be130dc71b64261264937a334dcc40b5ed3672d926375ad0c771081748c56b8e55b3c92e345353d82", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/579b3024259de75f300978137eb3510109a79e083f5192a39766e5d1207884024c3bf64babe37298e8cf98b467cd2328b83b37d71bbc503dad0671e6ec3f1d22", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/be64e4657dfb830a919fa842ff70066205d7e034c1e58130bd8beef2976f8bc18bfa2566f9887e548de79ae43011015afb8b047fa1a82e04e14a7a32233d2f2f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-30 13:00:19.107998) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 13:00:19.108357) ========= 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=d2a8c569965ab8367867b893000001a1-1496171467.168564-1124926776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 13:00:19.191271) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-30 13:00:19.191583) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-30 13:00:19.191898) ========= ========= Total master_lag: 0.19 =========