builder: mozilla-beta_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-082 starttime: 1495201336.19 results: success (0) revision: 0970997adcd5975c34f0969ffb6e865ed613f7ed ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-19 06:42:16.189020) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-19 06:42:16.189488) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-19 06:42:16.189788) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-19 06:42:16.229801) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 06:42:16.230104) ========= 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=51fc86400edbde9650d2781a000001d0-1495198785.892587-785134284 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-19 06:42:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 213M=0s 2017-05-19 06:42:16 (213 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.183664 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 06:42:16.442341) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 06:42:16.442655) ========= 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=51fc86400edbde9650d2781a000001d0-1495198785.892587-785134284 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021772 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 06:42:16.492352) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 06:42:16.492738) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0970997adcd5975c34f0969ffb6e865ed613f7ed --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 0970997adcd5975c34f0969ffb6e865ed613f7ed --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=51fc86400edbde9650d2781a000001d0-1495198785.892587-785134284 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-19 06:42:16,936 truncating revision to first 12 chars 2017-05-19 06:42:16,936 Setting DEBUG logging. 2017-05-19 06:42:16,936 attempt 1/10 2017-05-19 06:42:16,936 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/0970997adcd5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-19 06:42:17,263 unpacking tar archive at: mozilla-beta-0970997adcd5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.704585 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 06:42:17.212514) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-19 06:42:17.212831) ========= script_repo_revision: 0970997adcd5975c34f0969ffb6e865ed613f7ed ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-19 06:42:17.213198) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-19 06:42:17.213472) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-19 06:42:17.261625) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-05-19 06:42:17.261961) ========= /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=51fc86400edbde9650d2781a000001d0-1495198785.892587-785134284 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:42:17 INFO - MultiFileLogger online at 20170519 06:42:17 in /builds/slave/test 06:42:17 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 06:42:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:42:17 INFO - {'append_to_log': False, 06:42:17 INFO - 'base_work_dir': '/builds/slave/test', 06:42:17 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 06:42:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:42:17 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 06:42:17 INFO - 'buildbot_json_path': 'buildprops.json', 06:42:17 INFO - 'config_files': ('talos/linux_config.py',), 06:42:17 INFO - 'default_actions': ('clobber', 06:42:17 INFO - 'read-buildbot-config', 06:42:17 INFO - 'download-and-extract', 06:42:17 INFO - 'populate-webroot', 06:42:17 INFO - 'create-virtualenv', 06:42:17 INFO - 'install', 06:42:17 INFO - 'run-tests'), 06:42:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:42:17 INFO - 'download_minidump_stackwalk': True, 06:42:17 INFO - 'download_symbols': 'ondemand', 06:42:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:42:17 INFO - 'tooltool.py': '/tools/tooltool.py', 06:42:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:42:17 INFO - '/tools/misc-python/virtualenv.py')}, 06:42:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:42:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:42:17 INFO - 'gecko_profile': False, 06:42:17 INFO - 'gecko_profile_interval': 0, 06:42:17 INFO - 'installer_path': 'installer.exe', 06:42:17 INFO - 'log_level': 'info', 06:42:17 INFO - 'log_name': 'talos', 06:42:17 INFO - 'log_to_console': True, 06:42:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:42:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:42:17 INFO - 'opt_config_files': (), 06:42:17 INFO - 'pip_index': False, 06:42:17 INFO - 'suite': 'dromaeojs', 06:42:17 INFO - 'system_bits': '32', 06:42:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:42:17 INFO - 'title': 'talos-linux64-ix-082', 06:42:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:42:17 INFO - 'use_talos_json': True, 06:42:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:42:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:42:17 INFO - 'work_dir': 'build'} 06:42:17 INFO - [mozharness: 2017-05-19 13:42:17.908698Z] Running clobber step. 06:42:17 INFO - Running pre-action listener: _resource_record_pre_action 06:42:17 INFO - Running main action method: clobber 06:42:17 INFO - rmtree: /builds/slave/test/build 06:42:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:42:18 INFO - Running post-action listener: _resource_record_post_action 06:42:18 INFO - [mozharness: 2017-05-19 13:42:18.897085Z] Finished clobber step (success) 06:42:18 INFO - [mozharness: 2017-05-19 13:42:18.897185Z] Running read-buildbot-config step. 06:42:18 INFO - Running pre-action listener: _resource_record_pre_action 06:42:18 INFO - Running main action method: read_buildbot_config 06:42:18 INFO - Using buildbot properties: 06:42:18 INFO - { 06:42:18 INFO - "project": "", 06:42:18 INFO - "product": "firefox", 06:42:18 INFO - "who": "ffxbld@noreply.mozilla.org", 06:42:18 INFO - "installer_path": "public/build/target.tar.bz2", 06:42:18 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 06:42:18 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta/", 06:42:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs", 06:42:18 INFO - "stage_platform": "linux64", 06:42:18 INFO - "basedir": "/builds/slave/test", 06:42:18 INFO - "buildnumber": 49, 06:42:18 INFO - "platform": "ubuntu64_hw", 06:42:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:42:18 INFO - "slavebuilddir": "test", 06:42:18 INFO - "taskId": "AAFFA3yUTBqYD2uBOZ125Q", 06:42:18 INFO - "branch": "mozilla-beta", 06:42:18 INFO - "script_repo_revision": "production", 06:42:18 INFO - "revision": "0970997adcd5975c34f0969ffb6e865ed613f7ed", 06:42:18 INFO - "slavename": "talos-linux64-ix-082", 06:42:18 INFO - "repo_path": "releases/mozilla-beta" 06:42:18 INFO - } 06:42:18 INFO - Finding installer, test and symbols from parent task. 06:42:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AAFFA3yUTBqYD2uBOZ125Q'}, attempt #1 06:42:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AAFFA3yUTBqYD2uBOZ125Q'}, attempt #1 06:42:19 INFO - Task dependencies: f5o6xQYfRqyfL35s8TINNQ 06:42:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f5o6xQYfRqyfL35s8TINNQ'}, attempt #1 06:42:20 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/f5o6xQYfRqyfL35s8TINNQ/artifacts/public/build/target.tar.bz2 06:42:20 INFO - Set test_url: https://queue.taskcluster.net/v1/task/f5o6xQYfRqyfL35s8TINNQ/artifacts/public/build/test_packages.json 06:42:20 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/f5o6xQYfRqyfL35s8TINNQ/artifacts/public/build/target.crashreporter-symbols.zip 06:42:20 INFO - Running post-action listener: _resource_record_post_action 06:42:20 INFO - [mozharness: 2017-05-19 13:42:20.249546Z] Finished read-buildbot-config step (success) 06:42:20 INFO - [mozharness: 2017-05-19 13:42:20.249765Z] Running download-and-extract step. 06:42:20 INFO - Running pre-action listener: _resource_record_pre_action 06:42:20 INFO - Running main action method: download_and_extract 06:42:20 INFO - mkdir: /builds/slave/test/build/tests 06:42:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:42:20 INFO - trying https://queue.taskcluster.net/v1/task/f5o6xQYfRqyfL35s8TINNQ/artifacts/public/build/target.test_packages.json 06:42:20 INFO - Downloading https://queue.taskcluster.net/v1/task/f5o6xQYfRqyfL35s8TINNQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:42:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f5o6xQYfRqyfL35s8TINNQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:42:20 INFO - Downloaded 986 bytes. 06:42:20 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:42:20 INFO - Using the following test package requirements: 06:42:20 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 06:42:20 INFO - u'common': [u'target.common.tests.zip'], 06:42:20 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:42:20 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:42:20 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:42:20 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:42:20 INFO - u'mozbase': [u'target.common.tests.zip'], 06:42:20 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:42:20 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:42:20 INFO - u'web-platform': [u'target.common.tests.zip', 06:42:20 INFO - u'target.web-platform.tests.zip'], 06:42:20 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:42:20 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 06:42:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/f5o6xQYfRqyfL35s8TINNQ/artifacts/public/build/target.common.tests.zip 06:42:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f5o6xQYfRqyfL35s8TINNQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:42:20 INFO - Fetch https://queue.taskcluster.net/v1/task/f5o6xQYfRqyfL35s8TINNQ/artifacts/public/build/target.common.tests.zip into memory 06:42:23 INFO - Expected file size: 59545402 06:42:23 INFO - Obtained file size: 59545402 06:42:33 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 06:42:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/f5o6xQYfRqyfL35s8TINNQ/artifacts/public/build/target.common.tests.zip 06:42:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f5o6xQYfRqyfL35s8TINNQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:42:33 INFO - Fetch https://queue.taskcluster.net/v1/task/f5o6xQYfRqyfL35s8TINNQ/artifacts/public/build/target.common.tests.zip into memory 06:42:34 INFO - Expected file size: 59545402 06:42:34 INFO - Obtained file size: 59545402 06:42:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/f5o6xQYfRqyfL35s8TINNQ/artifacts/public/build/target.talos.tests.zip 06:42:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f5o6xQYfRqyfL35s8TINNQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:42:45 INFO - Fetch https://queue.taskcluster.net/v1/task/f5o6xQYfRqyfL35s8TINNQ/artifacts/public/build/target.talos.tests.zip into memory 06:42:47 INFO - Expected file size: 14404449 06:42:47 INFO - Obtained file size: 14404449 06:42:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:42:47 INFO - trying https://queue.taskcluster.net/v1/task/f5o6xQYfRqyfL35s8TINNQ/artifacts/public/build/target.tar.bz2 06:42:47 INFO - Downloading https://queue.taskcluster.net/v1/task/f5o6xQYfRqyfL35s8TINNQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:42:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f5o6xQYfRqyfL35s8TINNQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:42:48 INFO - Downloaded 59739370 bytes. 06:42:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f5o6xQYfRqyfL35s8TINNQ/artifacts/public/build/target.tar.bz2 06:42:48 INFO - mkdir: /builds/slave/test/properties 06:42:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:42:48 INFO - Writing to file /builds/slave/test/properties/build_url 06:42:48 INFO - Contents: 06:42:48 INFO - build_url:https://queue.taskcluster.net/v1/task/f5o6xQYfRqyfL35s8TINNQ/artifacts/public/build/target.tar.bz2 06:42:48 INFO - Running post-action listener: _resource_record_post_action 06:42:48 INFO - Running post-action listener: set_extra_try_arguments 06:42:48 INFO - [mozharness: 2017-05-19 13:42:48.541568Z] Finished download-and-extract step (success) 06:42:48 INFO - [mozharness: 2017-05-19 13:42:48.541665Z] Running populate-webroot step. 06:42:48 INFO - Running pre-action listener: _resource_record_pre_action 06:42:48 INFO - Running main action method: populate_webroot 06:42:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:42:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:42:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:42:48 INFO - '--tppagecycles', 06:42:48 INFO - '7'], 06:42:48 INFO - 'tests': ['tsvgm']}}, 06:42:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:42:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:42:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:42:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:42:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:42:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:42:48 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:42:48 INFO - 'talos_options': ['--disable-e10s'], 06:42:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:42:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:42:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:42:48 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:42:48 INFO - 'talos_options': ['--disable-e10s'], 06:42:48 INFO - 'tests': ['damp', 'tps']}, 06:42:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:42:48 INFO - 'tests': ['damp', 'tps']}, 06:42:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:42:48 INFO - 'tests': ['dromaeo_dom']}, 06:42:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:42:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:42:48 INFO - 'tests': ['basic_compositor_video']}, 06:42:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:42:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:42:48 INFO - 'tests': ['a11yr', 06:42:48 INFO - 'ts_paint', 06:42:48 INFO - 'tpaint', 06:42:48 INFO - 'sessionrestore', 06:42:48 INFO - 'sessionrestore_no_auto_restore', 06:42:48 INFO - 'tabpaint']}, 06:42:48 INFO - 'other-e10s': {'tests': ['a11yr', 06:42:48 INFO - 'ts_paint', 06:42:48 INFO - 'tpaint', 06:42:48 INFO - 'sessionrestore', 06:42:48 INFO - 'sessionrestore_no_auto_restore', 06:42:48 INFO - 'tabpaint']}, 06:42:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:42:48 INFO - 'ts_paint', 06:42:48 INFO - 'tpaint', 06:42:48 INFO - 'sessionrestore', 06:42:48 INFO - 'sessionrestore_no_auto_restore', 06:42:48 INFO - 'tabpaint']}, 06:42:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:42:48 INFO - 'ts_paint', 06:42:48 INFO - 'tpaint', 06:42:48 INFO - 'sessionrestore', 06:42:48 INFO - 'sessionrestore_no_auto_restore', 06:42:48 INFO - 'tabpaint']}, 06:42:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:42:48 INFO - 'tests': ['a11yr', 06:42:48 INFO - 'ts_paint', 06:42:48 INFO - 'tpaint', 06:42:48 INFO - 'sessionrestore', 06:42:48 INFO - 'sessionrestore_no_auto_restore', 06:42:48 INFO - 'tabpaint']}, 06:42:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:42:48 INFO - 'tests': ['a11yr', 06:42:48 INFO - 'ts_paint', 06:42:48 INFO - 'tpaint', 06:42:48 INFO - 'sessionrestore', 06:42:48 INFO - 'sessionrestore_no_auto_restore', 06:42:48 INFO - 'tabpaint']}, 06:42:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:42:48 INFO - 'tests': ['tsvgx', 06:42:48 INFO - 'tsvgr_opacity', 06:42:48 INFO - 'tart', 06:42:48 INFO - 'tscrollx', 06:42:48 INFO - 'cart', 06:42:48 INFO - 'tsvg_static']}, 06:42:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:42:48 INFO - 'tsvgr_opacity', 06:42:48 INFO - 'tart', 06:42:48 INFO - 'tscrollx', 06:42:48 INFO - 'cart', 06:42:48 INFO - 'tsvg_static']}, 06:42:48 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:42:48 INFO - 'talos_options': ['--disable-e10s'], 06:42:48 INFO - 'tests': ['tp5o']}, 06:42:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:42:48 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:42:48 INFO - 'talos_options': ['--disable-e10s', 06:42:48 INFO - '--xperf_path', 06:42:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:42:48 INFO - 'tests': ['tp5n']}, 06:42:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:42:48 INFO - 'talos_options': ['--xperf_path', 06:42:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:42:48 INFO - 'tests': ['tp5n']}}, 06:42:48 INFO - 'talos.zip': {'path': '', 06:42:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:42:48 INFO - Running post-action listener: _resource_record_post_action 06:42:48 INFO - [mozharness: 2017-05-19 13:42:48.554823Z] Finished populate-webroot step (success) 06:42:48 INFO - [mozharness: 2017-05-19 13:42:48.554913Z] Running create-virtualenv step. 06:42:48 INFO - Running pre-action listener: _resource_record_pre_action 06:42:48 INFO - Running main action method: create_virtualenv 06:42:48 INFO - Creating virtualenv /builds/slave/test/build/venv 06:42:48 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 06:42:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:42:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:42:48 INFO - Using real prefix '/usr' 06:42:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:42:49 INFO - Installing distribute.............................................................................................................................................................................................done. 06:42:51 INFO - Installing pip.................done. 06:42:51 INFO - Return code: 0 06:42:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:42:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:42:51 INFO - Reading from file tmpfile_stdout 06:42:51 INFO - Output received: 06:42:51 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) 06:42:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:42:51 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')]} 06:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42:51 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')]} 06:42:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42:51 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 0x15d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1615a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1875310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1872400>, '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 0x18733b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1873840>, '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': '51fc86400edbde9650d2781a000001d0-1495198785.892587-785134284', '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 06:42:51 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 06:42:51 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 06:42:51 INFO - Using env: {'DISPLAY': ':0', 06:42:51 INFO - 'HOME': '/home/cltbld', 06:42:51 INFO - 'LANG': 'en_US.UTF-8', 06:42:51 INFO - 'LANGUAGE': 'en_US:en', 06:42:51 INFO - 'LOGNAME': 'cltbld', 06:42:51 INFO - 'MAIL': '/var/mail/cltbld', 06:42:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:51 INFO - 'MOZ_NO_REMOTE': '1', 06:42:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:51 INFO - 'NO_EM_RESTART': '1', 06:42:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:51 INFO - 'PWD': '/builds/slave/test', 06:42:51 INFO - 'SHELL': '/bin/bash', 06:42:51 INFO - 'SHLVL': '1', 06:42:51 INFO - 'TERM': 'linux', 06:42:51 INFO - 'TMOUT': '86400', 06:42:51 INFO - 'USER': 'cltbld', 06:42:51 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1495198785.892587-785134284', 06:42:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:51 INFO - '_': '/tools/buildbot/bin/python'} 06:42:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:51 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 06:42:51 INFO - Cleaning up... 06:42:51 INFO - Return code: 0 06:42:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:42:51 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')]} 06:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42:51 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')]} 06:42:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42:51 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 0x15d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1615a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1875310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1872400>, '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 0x18733b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1873840>, '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': '51fc86400edbde9650d2781a000001d0-1495198785.892587-785134284', '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 06:42:51 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 06:42:51 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 06:42:51 INFO - Using env: {'DISPLAY': ':0', 06:42:51 INFO - 'HOME': '/home/cltbld', 06:42:51 INFO - 'LANG': 'en_US.UTF-8', 06:42:51 INFO - 'LANGUAGE': 'en_US:en', 06:42:51 INFO - 'LOGNAME': 'cltbld', 06:42:51 INFO - 'MAIL': '/var/mail/cltbld', 06:42:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:51 INFO - 'MOZ_NO_REMOTE': '1', 06:42:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:51 INFO - 'NO_EM_RESTART': '1', 06:42:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:51 INFO - 'PWD': '/builds/slave/test', 06:42:51 INFO - 'SHELL': '/bin/bash', 06:42:51 INFO - 'SHLVL': '1', 06:42:51 INFO - 'TERM': 'linux', 06:42:51 INFO - 'TMOUT': '86400', 06:42:51 INFO - 'USER': 'cltbld', 06:42:51 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1495198785.892587-785134284', 06:42:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:51 INFO - '_': '/tools/buildbot/bin/python'} 06:42:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:52 INFO - Downloading/unpacking psutil>=3.1.1 06:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:42:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:42:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:42:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:42:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:42:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:42:53 INFO - Installing collected packages: psutil 06:42:53 INFO - Running setup.py install for psutil 06:42:53 INFO - building 'psutil._psutil_linux' extension 06:42:53 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 06:42:54 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 06:42:54 INFO - building 'psutil._psutil_posix' extension 06:42:54 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 06:42:54 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 06:42:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:42:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:42:54 INFO - Successfully installed psutil 06:42:54 INFO - Cleaning up... 06:42:54 INFO - Return code: 0 06:42:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:42:54 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')]} 06:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42:54 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')]} 06:42:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42:54 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 0x15d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1615a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1875310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1872400>, '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 0x18733b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1873840>, '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': '51fc86400edbde9650d2781a000001d0-1495198785.892587-785134284', '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 06:42:54 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 06:42:54 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 06:42:54 INFO - Using env: {'DISPLAY': ':0', 06:42:54 INFO - 'HOME': '/home/cltbld', 06:42:54 INFO - 'LANG': 'en_US.UTF-8', 06:42:54 INFO - 'LANGUAGE': 'en_US:en', 06:42:54 INFO - 'LOGNAME': 'cltbld', 06:42:54 INFO - 'MAIL': '/var/mail/cltbld', 06:42:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:54 INFO - 'MOZ_NO_REMOTE': '1', 06:42:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:54 INFO - 'NO_EM_RESTART': '1', 06:42:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:54 INFO - 'PWD': '/builds/slave/test', 06:42:54 INFO - 'SHELL': '/bin/bash', 06:42:54 INFO - 'SHLVL': '1', 06:42:54 INFO - 'TERM': 'linux', 06:42:54 INFO - 'TMOUT': '86400', 06:42:54 INFO - 'USER': 'cltbld', 06:42:54 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1495198785.892587-785134284', 06:42:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:54 INFO - '_': '/tools/buildbot/bin/python'} 06:42:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:42:55 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 06:42:55 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 06:42:55 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 06:42:55 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 06:42:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:42:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:42:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:42:56 INFO - Installing collected packages: mozsystemmonitor 06:42:56 INFO - Running setup.py install for mozsystemmonitor 06:42:56 INFO - Successfully installed mozsystemmonitor 06:42:56 INFO - Cleaning up... 06:42:56 INFO - Return code: 0 06:42:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:42:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:42:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:42:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42:56 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 0x15d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1615a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1875310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1872400>, '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 0x18733b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1873840>, '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': '51fc86400edbde9650d2781a000001d0-1495198785.892587-785134284', '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 06:42:56 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 06:42:56 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 06:42:56 INFO - Using env: {'DISPLAY': ':0', 06:42:56 INFO - 'HOME': '/home/cltbld', 06:42:56 INFO - 'LANG': 'en_US.UTF-8', 06:42:56 INFO - 'LANGUAGE': 'en_US:en', 06:42:56 INFO - 'LOGNAME': 'cltbld', 06:42:56 INFO - 'MAIL': '/var/mail/cltbld', 06:42:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:56 INFO - 'MOZ_NO_REMOTE': '1', 06:42:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:56 INFO - 'NO_EM_RESTART': '1', 06:42:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:56 INFO - 'PWD': '/builds/slave/test', 06:42:56 INFO - 'SHELL': '/bin/bash', 06:42:56 INFO - 'SHLVL': '1', 06:42:56 INFO - 'TERM': 'linux', 06:42:56 INFO - 'TMOUT': '86400', 06:42:56 INFO - 'USER': 'cltbld', 06:42:56 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1495198785.892587-785134284', 06:42:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:56 INFO - '_': '/tools/buildbot/bin/python'} 06:42:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:56 INFO - Downloading/unpacking jsonschema==2.5.1 06:42:56 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 06:42:56 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 06:42:56 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 06:42:56 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 06:42:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:42:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:42:57 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 06:42:57 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 06:42:57 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 06:42:57 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 06:42:57 INFO - Downloading functools32-3.2.3-2.tar.gz 06:42:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:42:57 INFO - warning: no files found matching '*.txt' 06:42:57 INFO - no previously-included directories found matching 'build' 06:42:57 INFO - no previously-included directories found matching 'dist' 06:42:57 INFO - no previously-included directories found matching '.git*' 06:42:57 INFO - Installing collected packages: jsonschema, functools32 06:42:57 INFO - Running setup.py install for functools32 06:42:57 INFO - warning: no files found matching '*.txt' 06:42:57 INFO - no previously-included directories found matching 'build' 06:42:57 INFO - no previously-included directories found matching 'dist' 06:42:57 INFO - no previously-included directories found matching '.git*' 06:42:57 INFO - Successfully installed jsonschema functools32 06:42:57 INFO - Cleaning up... 06:42:57 INFO - Return code: 0 06:42:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:42: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')]} 06:42:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42: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')]} 06:42:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42:57 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 0x15d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1615a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1875310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1872400>, '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 0x18733b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1873840>, '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': '51fc86400edbde9650d2781a000001d0-1495198785.892587-785134284', '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 06:42:57 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 06:42:57 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 06:42:58 INFO - Using env: {'DISPLAY': ':0', 06:42:58 INFO - 'HOME': '/home/cltbld', 06:42:58 INFO - 'LANG': 'en_US.UTF-8', 06:42:58 INFO - 'LANGUAGE': 'en_US:en', 06:42:58 INFO - 'LOGNAME': 'cltbld', 06:42:58 INFO - 'MAIL': '/var/mail/cltbld', 06:42:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:58 INFO - 'MOZ_NO_REMOTE': '1', 06:42:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:58 INFO - 'NO_EM_RESTART': '1', 06:42:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:58 INFO - 'PWD': '/builds/slave/test', 06:42:58 INFO - 'SHELL': '/bin/bash', 06:42:58 INFO - 'SHLVL': '1', 06:42:58 INFO - 'TERM': 'linux', 06:42:58 INFO - 'TMOUT': '86400', 06:42:58 INFO - 'USER': 'cltbld', 06:42:58 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1495198785.892587-785134284', 06:42:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:58 INFO - '_': '/tools/buildbot/bin/python'} 06:42:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:42:58 INFO - Cleaning up... 06:42:58 INFO - Return code: 0 06:42:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:42:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:42:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:42:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x15d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1615a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1875310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1872400>, '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 0x18733b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1873840>, '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': '51fc86400edbde9650d2781a000001d0-1495198785.892587-785134284', '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 06:42:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:42:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:42:58 INFO - Using env: {'DISPLAY': ':0', 06:42:58 INFO - 'HOME': '/home/cltbld', 06:42:58 INFO - 'LANG': 'en_US.UTF-8', 06:42:58 INFO - 'LANGUAGE': 'en_US:en', 06:42:58 INFO - 'LOGNAME': 'cltbld', 06:42:58 INFO - 'MAIL': '/var/mail/cltbld', 06:42:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:58 INFO - 'MOZ_NO_REMOTE': '1', 06:42:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:58 INFO - 'NO_EM_RESTART': '1', 06:42:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:58 INFO - 'PWD': '/builds/slave/test', 06:42:58 INFO - 'SHELL': '/bin/bash', 06:42:58 INFO - 'SHLVL': '1', 06:42:58 INFO - 'TERM': 'linux', 06:42:58 INFO - 'TMOUT': '86400', 06:42:58 INFO - 'USER': 'cltbld', 06:42:58 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1495198785.892587-785134284', 06:42:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:58 INFO - '_': '/tools/buildbot/bin/python'} 06:42:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:58 INFO - Downloading/unpacking blobuploader==1.2.4 06:42:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:42:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:42:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:42:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:42:59 INFO - Downloading blobuploader-1.2.4.tar.gz 06:42:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:42:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:42:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:42:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:42:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:42:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:42:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:42:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:43:00 INFO - Downloading docopt-0.6.1.tar.gz 06:43:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:43:00 INFO - Installing collected packages: blobuploader, requests, docopt 06:43:00 INFO - Running setup.py install for blobuploader 06:43:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:43:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:43:00 INFO - Running setup.py install for requests 06:43:00 INFO - Running setup.py install for docopt 06:43:00 INFO - Successfully installed blobuploader requests docopt 06:43:00 INFO - Cleaning up... 06:43:00 INFO - Return code: 0 06:43:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:43:00 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')]} 06:43:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:43:00 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')]} 06:43:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:43:00 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 0x15d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1615a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1875310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1872400>, '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 0x18733b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1873840>, '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': '51fc86400edbde9650d2781a000001d0-1495198785.892587-785134284', '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 06:43:00 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 06:43:00 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 06:43:00 INFO - Using env: {'DISPLAY': ':0', 06:43:00 INFO - 'HOME': '/home/cltbld', 06:43:00 INFO - 'LANG': 'en_US.UTF-8', 06:43:00 INFO - 'LANGUAGE': 'en_US:en', 06:43:00 INFO - 'LOGNAME': 'cltbld', 06:43:00 INFO - 'MAIL': '/var/mail/cltbld', 06:43:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:43:00 INFO - 'MOZ_NO_REMOTE': '1', 06:43:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:43:00 INFO - 'NO_EM_RESTART': '1', 06:43:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:43:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:43:00 INFO - 'PWD': '/builds/slave/test', 06:43:00 INFO - 'SHELL': '/bin/bash', 06:43:00 INFO - 'SHLVL': '1', 06:43:00 INFO - 'TERM': 'linux', 06:43:00 INFO - 'TMOUT': '86400', 06:43:00 INFO - 'USER': 'cltbld', 06:43:00 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1495198785.892587-785134284', 06:43:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:43:00 INFO - '_': '/tools/buildbot/bin/python'} 06:43:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:43:00 INFO - Running setup.py (path:/tmp/pip-A21QWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:43:01 INFO - Running setup.py (path:/tmp/pip-Yt9Cqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:43:01 INFO - Running setup.py (path:/tmp/pip-j0Cd36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:43:01 INFO - Running setup.py (path:/tmp/pip-ru2ueE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:43:01 INFO - Running setup.py (path:/tmp/pip-iRqqce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:43:01 INFO - Running setup.py (path:/tmp/pip-UXtl8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:43:01 INFO - Running setup.py (path:/tmp/pip-3PI2MD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:43:01 INFO - Running setup.py (path:/tmp/pip-mWRN32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:43:01 INFO - Running setup.py (path:/tmp/pip-vrS5Ft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:43:01 INFO - Running setup.py (path:/tmp/pip-4XbWMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:43:01 INFO - Running setup.py (path:/tmp/pip-uzvYnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:43:01 INFO - Running setup.py (path:/tmp/pip-Flj87j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:43:01 INFO - Running setup.py (path:/tmp/pip-Y_jWbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:43:01 INFO - Running setup.py (path:/tmp/pip-nC2M9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:43:01 INFO - Running setup.py (path:/tmp/pip-EIWEBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:43:02 INFO - Running setup.py (path:/tmp/pip-yYALGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:43:02 INFO - Running setup.py (path:/tmp/pip-VEppZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:43:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:43:02 INFO - Running setup.py install for manifestparser 06:43:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:43:02 INFO - Running setup.py install for mozcrash 06:43:02 INFO - Running setup.py install for mozdebug 06:43:02 INFO - Running setup.py install for mozdevice 06:43:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:43:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:43:02 INFO - Running setup.py install for mozfile 06:43:02 INFO - Running setup.py install for mozhttpd 06:43:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:43:02 INFO - Running setup.py install for mozinfo 06:43:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:43:02 INFO - Running setup.py install for mozInstall 06:43:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:43:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:43:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:43:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:43:02 INFO - Running setup.py install for mozleak 06:43:03 INFO - Running setup.py install for mozlog 06:43:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:43:03 INFO - Running setup.py install for moznetwork 06:43:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:43:03 INFO - Running setup.py install for mozprocess 06:43:03 INFO - Running setup.py install for mozprofile 06:43:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:43:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:43:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:43:03 INFO - Running setup.py install for mozrunner 06:43:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:43:03 INFO - Running setup.py install for mozscreenshot 06:43:03 INFO - Running setup.py install for moztest 06:43:03 INFO - Running setup.py install for mozversion 06:43:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:43:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:43:03 INFO - Cleaning up... 06:43:03 INFO - Return code: 0 06:43:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:43: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')]} 06:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:43: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')]} 06:43:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:43:03 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 0x15d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1615a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1875310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1872400>, '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 0x18733b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1873840>, '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': '51fc86400edbde9650d2781a000001d0-1495198785.892587-785134284', '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 06:43:03 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 06:43:03 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 06:43:03 INFO - Using env: {'DISPLAY': ':0', 06:43:03 INFO - 'HOME': '/home/cltbld', 06:43:03 INFO - 'LANG': 'en_US.UTF-8', 06:43:03 INFO - 'LANGUAGE': 'en_US:en', 06:43:03 INFO - 'LOGNAME': 'cltbld', 06:43:03 INFO - 'MAIL': '/var/mail/cltbld', 06:43:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:43:03 INFO - 'MOZ_NO_REMOTE': '1', 06:43:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:43:03 INFO - 'NO_EM_RESTART': '1', 06:43:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:43:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:43:03 INFO - 'PWD': '/builds/slave/test', 06:43:03 INFO - 'SHELL': '/bin/bash', 06:43:03 INFO - 'SHLVL': '1', 06:43:03 INFO - 'TERM': 'linux', 06:43:03 INFO - 'TMOUT': '86400', 06:43:03 INFO - 'USER': 'cltbld', 06:43:03 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1495198785.892587-785134284', 06:43:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:43:03 INFO - '_': '/tools/buildbot/bin/python'} 06:43:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:43:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:43:04 INFO - Running setup.py (path:/tmp/pip-FVXme8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:43:04 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)) 06:43:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:43:04 INFO - Running setup.py (path:/tmp/pip-Oidj6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:43:04 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)) 06:43:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:43:04 INFO - Running setup.py (path:/tmp/pip-8dWRqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:43:04 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)) 06:43:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:43:04 INFO - Running setup.py (path:/tmp/pip-FBwz5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:43:04 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)) 06:43:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:43:04 INFO - Running setup.py (path:/tmp/pip-UB1oZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:43:04 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)) 06:43:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:43:04 INFO - Running setup.py (path:/tmp/pip-tiULZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:43:04 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)) 06:43:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:43:04 INFO - Running setup.py (path:/tmp/pip-qqQ0xi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:43:04 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)) 06:43:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:43:04 INFO - Running setup.py (path:/tmp/pip-6CqfC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:43:04 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)) 06:43:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:43:04 INFO - Running setup.py (path:/tmp/pip-zkKRke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:43:04 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)) 06:43:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:43:04 INFO - Running setup.py (path:/tmp/pip-WZ57dP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:43:04 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)) 06:43:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:43:04 INFO - Running setup.py (path:/tmp/pip-3ASHZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:43:04 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)) 06:43:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:43:04 INFO - Running setup.py (path:/tmp/pip-YArdYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:43:05 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)) 06:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:43:05 INFO - Running setup.py (path:/tmp/pip-12ZX7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:43:05 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)) 06:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:43:05 INFO - Running setup.py (path:/tmp/pip-4n0N2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:43:05 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)) 06:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:43:05 INFO - Running setup.py (path:/tmp/pip-JLWZz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:43:05 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)) 06:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:43:05 INFO - Running setup.py (path:/tmp/pip-icFQiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:43:05 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)) 06:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:43:05 INFO - Running setup.py (path:/tmp/pip-h6if7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:43:05 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)) 06:43:05 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)) 06:43:05 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)) 06:43:05 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)) 06:43:05 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)) 06:43:05 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)) 06:43:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:43: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 06:43: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 06:43: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 06:43: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 06:43:06 INFO - Downloading blessings-1.6.tar.gz 06:43:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:43:06 INFO - Installing collected packages: blessings 06:43:06 INFO - Running setup.py install for blessings 06:43:06 INFO - Successfully installed blessings 06:43:06 INFO - Cleaning up... 06:43:06 INFO - Return code: 0 06:43:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:43:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:43:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:43:06 INFO - Reading from file tmpfile_stdout 06:43:06 INFO - Current package versions: 06:43:06 INFO - argparse == 1.2.1 06:43:06 INFO - blessings == 1.6 06:43:06 INFO - blobuploader == 1.2.4 06:43:06 INFO - docopt == 0.6.1 06:43:06 INFO - functools32 == 3.2.3-2 06:43:06 INFO - jsonschema == 2.5.1 06:43:06 INFO - manifestparser == 1.1 06:43:06 INFO - mozInstall == 1.12 06:43:06 INFO - mozcrash == 1.0 06:43:06 INFO - mozdebug == 0.1 06:43:06 INFO - mozdevice == 0.49 06:43:06 INFO - mozfile == 1.2 06:43:06 INFO - mozhttpd == 0.7 06:43:06 INFO - mozinfo == 0.9 06:43:06 INFO - mozleak == 0.1 06:43:06 INFO - mozlog == 3.4 06:43:06 INFO - moznetwork == 0.27 06:43:06 INFO - mozprocess == 0.25 06:43:06 INFO - mozprofile == 0.28 06:43:06 INFO - mozrunner == 6.13 06:43:06 INFO - mozscreenshot == 0.1 06:43:06 INFO - mozsystemmonitor == 0.3 06:43:06 INFO - moztest == 0.8 06:43:06 INFO - mozversion == 1.4 06:43:06 INFO - psutil == 3.1.1 06:43:06 INFO - requests == 1.2.3 06:43:06 INFO - wsgiref == 0.1.2 06:43:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:43: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')]} 06:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:43: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')]} 06:43:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:43:06 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 0x15d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1615a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1875310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1872400>, '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 0x18733b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1873840>, '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': '51fc86400edbde9650d2781a000001d0-1495198785.892587-785134284', '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 06:43:06 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 06:43:06 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 06:43:06 INFO - Using env: {'DISPLAY': ':0', 06:43:06 INFO - 'HOME': '/home/cltbld', 06:43:06 INFO - 'LANG': 'en_US.UTF-8', 06:43:06 INFO - 'LANGUAGE': 'en_US:en', 06:43:06 INFO - 'LOGNAME': 'cltbld', 06:43:06 INFO - 'MAIL': '/var/mail/cltbld', 06:43:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:43:06 INFO - 'MOZ_NO_REMOTE': '1', 06:43:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:43:06 INFO - 'NO_EM_RESTART': '1', 06:43:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:43:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:43:06 INFO - 'PWD': '/builds/slave/test', 06:43:06 INFO - 'SHELL': '/bin/bash', 06:43:06 INFO - 'SHLVL': '1', 06:43:06 INFO - 'TERM': 'linux', 06:43:06 INFO - 'TMOUT': '86400', 06:43:06 INFO - 'USER': 'cltbld', 06:43:06 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1495198785.892587-785134284', 06:43:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:43:06 INFO - '_': '/tools/buildbot/bin/python'} 06:43:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:43:07 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)) 06:43:07 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)) 06:43:07 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)) 06:43:07 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)) 06:43:07 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)) 06:43:07 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)) 06:43:07 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)) 06:43:07 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)) 06:43:07 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)) 06:43:07 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)) 06:43:07 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)) 06:43:07 INFO - Cleaning up... 06:43:07 INFO - Return code: 0 06:43:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:43:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:43:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:43:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:43:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:43:07 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 0x15d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1615a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1875310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1872400>, '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 0x18733b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1873840>, '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': '51fc86400edbde9650d2781a000001d0-1495198785.892587-785134284', '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 06:43:07 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 06:43:07 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 06:43:07 INFO - Using env: {'DISPLAY': ':0', 06:43:07 INFO - 'HOME': '/home/cltbld', 06:43:07 INFO - 'LANG': 'en_US.UTF-8', 06:43:07 INFO - 'LANGUAGE': 'en_US:en', 06:43:07 INFO - 'LOGNAME': 'cltbld', 06:43:07 INFO - 'MAIL': '/var/mail/cltbld', 06:43:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:43:07 INFO - 'MOZ_NO_REMOTE': '1', 06:43:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:43:07 INFO - 'NO_EM_RESTART': '1', 06:43:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:43:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:43:07 INFO - 'PWD': '/builds/slave/test', 06:43:07 INFO - 'SHELL': '/bin/bash', 06:43:07 INFO - 'SHLVL': '1', 06:43:07 INFO - 'TERM': 'linux', 06:43:07 INFO - 'TMOUT': '86400', 06:43:07 INFO - 'USER': 'cltbld', 06:43:07 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1495198785.892587-785134284', 06:43:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:43:07 INFO - '_': '/tools/buildbot/bin/python'} 06:43:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:43:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:43:07 INFO - Cleaning up... 06:43:07 INFO - Return code: 0 06:43:07 INFO - Running post-action listener: _resource_record_post_action 06:43:07 INFO - Running post-action listener: _start_resource_monitoring 06:43:07 INFO - Starting resource monitoring. 06:43:07 INFO - [mozharness: 2017-05-19 13:43:07.474957Z] Finished create-virtualenv step (success) 06:43:07 INFO - [mozharness: 2017-05-19 13:43:07.475908Z] Running install step. 06:43:07 INFO - Running pre-action listener: _resource_record_pre_action 06:43:07 INFO - Running main action method: install 06:43:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:43:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:43:07 INFO - Reading from file tmpfile_stdout 06:43:07 INFO - Detecting whether we're running mozinstall >=1.0... 06:43:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:43:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:43:07 INFO - Reading from file tmpfile_stdout 06:43:07 INFO - Output received: 06:43:07 INFO - Usage: mozinstall [options] installer 06:43:07 INFO - Options: 06:43:07 INFO - -h, --help show this help message and exit 06:43:07 INFO - -d DEST, --destination=DEST 06:43:07 INFO - Directory to install application into. [default: 06:43:07 INFO - "/builds/slave/test"] 06:43:07 INFO - --app=APP Application being installed. [default: firefox] 06:43:07 INFO - mkdir: /builds/slave/test/build/application 06:43:07 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'] 06:43:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:43:21 INFO - Reading from file tmpfile_stdout 06:43:21 INFO - Output received: 06:43:21 INFO - /builds/slave/test/build/application/firefox/firefox 06:43:21 INFO - Running post-action listener: _resource_record_post_action 06:43:21 INFO - [mozharness: 2017-05-19 13:43:21.890576Z] Finished install step (success) 06:43:21 INFO - [mozharness: 2017-05-19 13:43:21.890822Z] Running run-tests step. 06:43:21 INFO - Running pre-action listener: _resource_record_pre_action 06:43:21 INFO - Running main action method: run_tests 06:43:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:43:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:43:21 INFO - Python 2.7.3 06:43:21 INFO - Return code: 0 06:43:21 INFO - grabbing minidump binary from tooltool 06:43:21 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')]} 06:43:21 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 0x1872400>, '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 0x18733b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1873840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:43:21 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 06:43:21 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 06:43:21 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 06:43:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:43:22 INFO - Return code: 0 06:43:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:43:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:43:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:43:22 INFO - ENV: RUST_BACKTRACE is now 1 06:43:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:43:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:43:22 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/f5o6xQYfRqyfL35s8TINNQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-082', '--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 06:43:22 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/f5o6xQYfRqyfL35s8TINNQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-082 --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 06:43:22 INFO - Using env: {'DISPLAY': ':0', 06:43:22 INFO - 'HOME': '/home/cltbld', 06:43:22 INFO - 'LANG': 'en_US.UTF-8', 06:43:22 INFO - 'LANGUAGE': 'en_US:en', 06:43:22 INFO - 'LOGNAME': 'cltbld', 06:43:22 INFO - 'MAIL': '/var/mail/cltbld', 06:43:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:43:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:43:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:43:22 INFO - 'MOZ_NO_REMOTE': '1', 06:43:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:43:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:43:22 INFO - 'NO_EM_RESTART': '1', 06:43:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:43:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:43:22 INFO - 'PWD': '/builds/slave/test', 06:43:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:43:22 INFO - 'RUST_BACKTRACE': '1', 06:43:22 INFO - 'SHELL': '/bin/bash', 06:43:22 INFO - 'SHLVL': '1', 06:43:22 INFO - 'TERM': 'linux', 06:43:22 INFO - 'TMOUT': '86400', 06:43:22 INFO - 'USER': 'cltbld', 06:43:22 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1495198785.892587-785134284', 06:43:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:43:22 INFO - '_': '/tools/buildbot/bin/python'} 06:43:22 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/f5o6xQYfRqyfL35s8TINNQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-082', '--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 06:43:22 INFO - mozversion application_buildid: 20170519123931 06:43:22 INFO - mozversion application_changeset: 0970997adcd5975c34f0969ffb6e865ed613f7ed 06:43:22 INFO - mozversion application_display_name: Firefox 06:43:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:43:22 INFO - mozversion application_name: Firefox 06:43:22 INFO - mozversion application_remotingname: firefox 06:43:22 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 06:43:22 INFO - mozversion application_vendor: Mozilla 06:43:22 INFO - mozversion application_version: 54.0 06:43:22 INFO - mozversion platform_buildid: 20170519123931 06:43:22 INFO - mozversion platform_changeset: 0970997adcd5975c34f0969ffb6e865ed613f7ed 06:43:22 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 06:43:22 INFO - mozversion platform_version: 54.0 06:43:22 INFO - using testdate: 1495201402 06:43:22 INFO - actual date: 1495201402 06:43:22 INFO - starting webserver on 'localhost:59600' 06:43:22 INFO - SUITE-START | Running 2 tests 06:43:22 INFO - TEST-START | dromaeo_css 06:43:22 INFO - operating with platform_type : linux_ 06:43:22 INFO - Initialising browser for dromaeo_css test... 06:43:22 INFO - TEST-INFO | started process 3308 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRMj5Vd/profile http://localhost:59600/getInfo.html) 06:43:27 INFO - PROCESS | 3308 | __metrics Screen width/height:1600/1200 06:43:27 INFO - PROCESS | 3308 | colorDepth:24 06:43:27 INFO - PROCESS | 3308 | Browser inner width/height: 1024/697 06:43:27 INFO - PROCESS | 3308 | __metrics 06:43:28 INFO - PROCESS | 3308 | 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" 06:43:28 INFO - PROCESS | 3308 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:43:29 INFO - TEST-INFO | 3308: exit 0 06:43:29 INFO - Browser initialized. 06:43:29 INFO - Running cycle 1/1 for dromaeo_css test... 06:43:29 INFO - TEST-INFO | started process 3404 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRMj5Vd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:43:41 INFO - PROCESS | 3404 | RSS: Main: 140759040 06:43:41 INFO - PROCESS | 3404 | 06:46:42 INFO - PROCESS | 3404 | Cycle 1(1): loaded http://localhost:59600/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59600/tests/dromaeo/cssquery-ext.html) 06:46:44 INFO - PROCESS | 3404 | RSS: Main: 287674368 06:46:44 INFO - PROCESS | 3404 | 06:49:46 INFO - PROCESS | 3404 | Cycle 1(1): loaded http://localhost:59600/tests/dromaeo/cssquery-ext.html (next: http://localhost:59600/tests/dromaeo/cssquery-jquery.html) 06:49:47 INFO - PROCESS | 3404 | RSS: Main: 226156544 06:49:47 INFO - PROCESS | 3404 | 06:52:49 INFO - PROCESS | 3404 | Cycle 1(1): loaded http://localhost:59600/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59600/tests/dromaeo/cssquery-mootools.html) 06:52:49 INFO - PROCESS | 3404 | RSS: Main: 171421696 06:52:49 INFO - PROCESS | 3404 | 06:55:51 INFO - PROCESS | 3404 | Cycle 1(1): loaded http://localhost:59600/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59600/tests/dromaeo/cssquery-prototype.html) 06:55:52 INFO - PROCESS | 3404 | RSS: Main: 171642880 06:55:52 INFO - PROCESS | 3404 | 06:58:54 INFO - PROCESS | 3404 | Cycle 1(1): loaded http://localhost:59600/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59600/tests/dromaeo/cssquery-yui.html) 06:58:55 INFO - PROCESS | 3404 | RSS: Main: 174686208 06:58:55 INFO - PROCESS | 3404 | 07:01:58 INFO - PROCESS | 3404 | Cycle 1(1): loaded http://localhost:59600/tests/dromaeo/cssquery-yui.html (next: http://localhost:59600/tests/dromaeo/cssquery-dojo.html) 07:01:58 INFO - PROCESS | 3404 | RSS: Main: 267513856 07:01:58 INFO - PROCESS | 3404 | 07:01:58 INFO - PROCESS | 3404 | __start_tp_report 07:01:58 INFO - PROCESS | 3404 | _x_x_mozilla_page_load 07:01:58 INFO - PROCESS | 3404 | _x_x_mozilla_page_load_details 07:01:58 INFO - PROCESS | 3404 | |i|pagename|runs| 07:01:58 INFO - PROCESS | 3404 | |0;dojo.html;3341.966580334197;3406.6763657452548;3430.193904432458;3439.3293307804956;3469.2714529948707;5687.544996400288;5795.449432303935;5797.043487824514;5803.303603567572;5819.7963071292515;5741.311042674874;5804.941950580493;5811.651300921948;5820.3597604263605;5826.650400975934;5142;5170.741462926858;5209.973950130244;5217.921731174036;5254.947450525484;5029.84910452687;5048.091343558158;5244.895102097956;5247.632665713401;5255.579553635719;5124.974375128119;5148.8712782180555;5167.586593072564;5168.302279192318;5185.662931909414;5256.763445644955;5265.842024739264;5266.973665131688;5274.208868669692;5297.099493086184;5109.540141387256;5155;5207.531322181022;5222.399424066243;5226.8693282667855;5585.106382978704;5589.832305030855;5646.887062258732;5656.151577263402;5756.597038207327;6160.1375807387;6184.226971628546;6195.411435913581;6198.442140207403;6218.005119180954;6252.6561039142825;6276.027215781562;6277.2153480814895;6289.119523266746;6291.6854157291955;5639.68981706006;5689.089745640677;5754.108113242454;5783.826485205451;5831.88336233273;6387.776427825004;6388.329225431356;6390;6393.904091438632;6399.328070552618;6014.368491308437;6111;6122.663253521099;6123.357047509948;6128.4790792783115;5972.163897054415;6008.429199226067;6179.073139029181;6213.502919766408;6220.502359811204;6106.703146374829;6109.175261339751;6113.32428171423;6132.63204207749;6141.324454310023;5937.198478205473;5987.461128498456;6136.764169924236;6138.600990935575;6149.13912052313;4699.835505757351;4716;4748;4772.045590881838;4774.976125119421;4134.049168691218;4239.173361194599;4251.3622956556765;4255.787210639518;4270.7864606769535;5847.9415205848245;5918.526517878559;5926.525877929842;5943.31651860033;5950.642961422329;6264.436200741955;6273.8745225095245;6285.371462853769;6291.182146321041;6296.622202667854;5945.167676525203;5953.047512397996;5958.910616340759;5987.550933679991;6001.729922153426;5123.231515272739;5161.3032240647035;5165.070287348238;5227.712475813867;5254.15933450646;6490.448311893542;6492.448141907897;6494.545381823227;6507.21913370408;6509.4792416605615;6232.906506402498;6240.719167637377;6284.151639528605;6287.371262873676;6297.842553936188;6262.3111457738705;6284.968575157095;6307.842303942254;6320.051992201206;6513.576617519846;6059.242594675666;6062.787802426894;6066.1204125402455;6091.573589848668;6110.450059494667;6173.228346456693;6211;6214.098955651315;6216.875662486635;6227.439530442282;5835.270591176103;5925.555583331181;5940.108983652487;6056.182415373868;6102.4812890902995;5951.7619295227705;5962.522998160223;5969.432903874125;5975.342712301556;5986.9401305986385;5959.553033522589;5960.5827592068135;5961.165436838759;5973.372795856372;5979.043353063489;5909.881802364014;5930.940690593039;5979.3123790762875;5980.192673988956;5997.5501837363245;5902.793402230901;5905.40945905406;5907.793227237026;5913.615614985012;5915.881682366415 07:01:58 INFO - PROCESS | 3404 | |1;ext.html;808.9555074470906;836.1794256113504;846.3229416466827;921.0743203080903;923.8891333040036;30890.227744306376;43473.78263108684;44083.33874991874;44190.558094419044;44198;45636.77181614087;45708;45746.7712661437;45835;46094.53905460944;7724.266194711493;7906.960465197666;9013.32400069994;9146.954265228698;9175;10622.62820801272;10848.511816968215;10851.131909447226;10852;11238.381888996142;10900.454977251145;10954.068904143158;10955.780884382308;10955.83566246507;10957.397343146124;10809.135269178447;10842.132629389629;10855.728606784893;10886.183536234774;10919.672409827677;10588.470576471145;10646.467676616216;10653.893461065367;10654.360738355723;10657.946710266398;43361;43451.56548434507;43506.347404788954;43895.34156987648;43935.340969885474;4272.572742725733;4318.654507639381;4340.696151269412;4420.602145806893;4439.822407103712;30289.09132726022;30745.69254307473;30982.690173098206;31217;32033.359332813212;4285.892852678708;4411.845585404528;4425.181341451809;4458.1306645204195;4462.352958820953;243094;243239;243498;243990;244071;47678.76160619175;47724.761376192895;47919.76040119777;47947.52052479431;47983;48123.5187648126;48256.517434825204;48285.75857120692;48333.03333933372;48377.5162248373;15912.92043539775;16306;16323.428679996143;16323.673526529403;16329.265183066553;11011.064059555027;11037.11703063753;13790.310484475936;14342.49801256951;14379.137251764927;12527.874721252852;12608.369581520887;12639.1784534005;12645.43095560702;12671.746565068832;5314.707691077027;5365.570754339644;5425.701586412706;5481.808136715275;5530.778768849201;1023.4319952426475;1026.6560702164709;1042.968710938673;1044.4516628769804;1056.102313033915;29278;29406.11781646554;29453.55819662707;29617.703822961495;30054.098377048722;1109.7503061811028;1116.3023110555903;1128.4132251229478;1130.1919127823646;1167.6788883057056;15388.538343849703;17097.145142742815;17166.485005449857;18286.268549257882;18335.266589336276;327125;327894;327915;329002;329179;55747;55826;56027.43972560222;56097.43902561004;56137;1512.7655213441933;1514.9318280677396;1522.2160587297328;1547.636305468214;1585.9762103568455;28721.71278287274;29468.852655736584;29635.407291854473;30323.393532128794;31147.844260779457;39400.802995984835;39551.80224098861;39661.60338396579;39683.60316396799;39727.80136099301;306548;307298;307476;307931;308035;25734.613980790677;26239.73760262373;29524.409511810074;32061.51907721433;32380.83809580937;40783.184336312515;41140;41248.38127428151;41453.378199327635;41802.37296440495;31479.685203147674;31615.525767113053;31708.365832682757;32025.519617205293;32260.516092258167;31447.685523145392;31448.213794654403;31521.52717709282;31629.683703162675;32272;35970;36206;36347.81826090853;36412.27175456423;36651.633483665886;29914.850425747733;30064.699353007065;30446.84776576103;30640.540391894585;30869.536956946115;23330.28907242659;23985.28044158678;24117.397065073514;24343;24431.51136977286 07:01:58 INFO - PROCESS | 3404 | |2;jquery.html;435.5709626018373;445.68133784344207;452.7622997926088;456.1993701054649;482.7369083849302;20560.280390186348;22313.553728925453;22499.887500562494;23262.3021309361;23528.88235558824;22793.544129117407;23038.88480557599;23156.42108947273;23398.298051058453;23664.5267094658;6689.632070236135;6763.560368576052;6897.896531552031;6931.341522555349;6980.895286570705;6624.675064987022;6782.762603308885;6906.723731050777;6907.171139463271;6915.273896240898;6793.728250869959;6847.554908930929;6852.109225800664;6856.485763567753;6858.074159988388;6759.053732477457;6763.864722705567;6807.455403567703;6826.69279882404;6851.417629501499;6659.067730517731;6694.230163531208;6708.9664551677415;6710;6715.731370745164;25990.87004564965;26104.73895261061;26137.73862261372;26269.605955910676;26584.73415265842;3661.521554523187;3724.7206459515646;3739.8691045813266;3787.9810600947094;3820.9808950955066;16100;17205.569860753458;17341;17629.471115866418;18024.459266222035;2213.944651383712;2282.201229569654;2297.1959814064944;2318.9188378406843;2386.248331775485;81125;91399;91857.54071229669;94074.05925940721;95249.52375238079;18495.352662656744;18598.907005465157;18711.157997890128;18811;18834.15246313919;33843.323133537684;34597.13507162341;34607.82696086504;34672.30655386878;35214.471782923276;11438;11504.25222360544;11688.590899318484;11703.707407314714;11707.2975621463;9770.413775173512;9780.804383912282;9780.95109524462;9794.559244834;9931.900680993098;10204.642837500653;10250.538725757358;10271;10466.162706983423;10548.156147508182;3567.375709250871;3579.8031108288774;3791.9241615168094;3867.7872717000837;4003.4395184674167;978.7993461340408;987.195435719886;990.6136606723384;993.8707967964118;1018.8930162332848;22190.223342182948;22442.775572244394;22587.20944766925;22715.772842271697;22828.885855570617;1013.3717095400899;1013.5084484025242;1022.8107800057013;1023.4166525080782;1030.1810061001522;12017;12933.935330323287;13036.348182591022;13091.08362414641;13230.801537976939;490393;515749;627846;653462;657855;79614;101470;115008.42495787636;118332.99999999828;124719;1287.304855378104;1371.4788380415378;1396.832380114393;1416.3767942105442;1473.7199932013098;19297.324593639154;19542.31601893927;20034.799652003876;20035;20037.098330574867;51817;51883.221751673;52330.47669523256;52503.737481312346;53334.19998699945;68556;68709.65645171743;69539;69579.30420695728;70675;13093.083484156017;13131.277779722206;13368.264745439094;13425.127366721132;13822.861771382157;14092.154470731788;14435.278236088363;14572.927135364256;14573.271336433349;14816.40734370613;12910.870891290966;12997.415116319977;13027.674308142372;13117.278549679477;13188.274644894624;11595.130365222474;11803.055755539364;11938.52245910154;11962.581309654468;12383.318917459626;12937;12948.8057679133;13273.734525309634;13325.533606323732;13377.799333009818;13315.467381305027;13322.666933326744;13326.600201993955;13477.46090156422;13480.595582132551;12324.876751232732;12537.373131343578;12624.17942833713;12648.620541383772;12899.871001289866 07:01:58 INFO - PROCESS | 3404 | |3;mootools.html;1555.9844401555981;1558.127448628768;1576.1252504859801;1582.9841701582984;1595.880308976827;10641;11318.717032074203;11318.886811131886;11324.15068869835;11328.433578321092;10809.513571889263;11226.719332016704;11247.100231981442;11249.887501124986;11250.156238282141;2521.848689078661;2555.5527782638055;2558.539462896678;2562.9871850640816;2564.1025641025676;2454.828162028659;2490.9252722418355;2524.835885667426;2529.747025297474;2529.886155123024;2416.613341865302;2473.5671257529953;2549.222487141421;2555.3611597100726;2561.398071453207;2365.7989070928993;2417.601095819188;2423.212455951814;2492.962605560918;2508.3102146909746;2402.7957623602015;2402.9399265018515;2442.364985103868;2444.4499987502845;2447.7185123710824;11637.767244655144;11701.414929253504;11704.765904681859;11767.646970590897;11794.528218871235;5915.763369465216;6079.20970273866;6086.056661217474;6090.26916769986;6091.329953705089;3405.6083550391527;3492.231709024011;3549.6095429502734;3740.3080430120244;3814.828332725034;1399.1465206224195;1422.3315041930275;1447.5886011139055;2354.6114891042957;2387.188355958965;14826.258687065603;15185.772213416807;17063.146842657818;17578;17794.199261033285;4587.357769912215;4704.411948506437;4819.325294458778;4825.4933232010835;4843.75781210938;12802;12813;12838.42227099764;12847.100702950891;12852.357382130856;5914.64512129265;5928.911066334009;5929.347771745104;5929.911051334234;5932.970335148383;5425.484578964992;5533.501984821305;5539.169124631257;5545.029619816516;5605.187247849039;4068.1058367420146;4101.159262351211;4126.504819421689;4144.336906095071;4163.458750362433;1064.6167379743285;1066.664000839733;1070.4326706845384;1086.7228856641507;1089.003561741014;871.4161511787117;873.1486800369589;900.5722281916169;943.6366998705548;1109.4896347680158;7266.890996635055;7313.634318284065;7347.963260183665;7438.326376565229;7490.400767938552;1073.2326386633595;1085.7122862441458;1087.0705546757408;1118.5413980268213;1145.1869172887343;4456.24243878535;4486.528914463999;4609.101225261109;4625.4911959684405;4691.554302341272;14334.068285561614;14836.554903352917;14880.62798430048;14904.403823847142;14915.850841491663;14367.850571954219;14615.488457903923;14857;14895.404183832525;14902.478413255483;8926.955365223132;10613;10856.565737370574;10911.127109831194;10918.617848375268;6390.297067322498;7264.273572642694;7398.704051838082;7486.663100160615;7594.582297973665;11897.583584574499;12002.819957700816;12003.699907502383;12406.379681015733;12553.435095420911;12597.685057873627;12725;12755.93622031921;12836.743265134832;12852.871471285542;9239.491827949527;9311.208547273558;9395.812083758423;9417.199538039344;9423.29325300619;10776.29954052984;10816.513256903616;10844.24090313702;10859.782804344028;10863.348199108079;9147.77130571741;9230.630774768933;9245.537723113683;9280.303977201602;9364.906350936404;9032.729018129467;9159.313051521029;9162.862557061517;9307.441553506811;9324.347295689236;8566.314694824523;8625.69810056645;8664.956675216836;8728.65085396577;8772.736817895473;6380;6405.807825765234;6440.484761218998;6572.704228309642;6646.60120392778;6224.346443623535;6404.487640988803;6409.551331406757;6414;6532.302319780494 07:01:58 INFO - PROCESS | 3404 | |4;prototype.html;418.5270644172085;421.2081287180102;421.59948049353085;421.76591991444735;424.1411142436568;5301.867453313665;5305.946940530594;5314.627976041674;5328.706921119337;5342.545883599893;4980.003999200157;5005.522266478099;5188.766505507252;5223.582113430926;5256.316678831747;4111.5477297497255;4189.916201675965;4208.579142085782;4209.6421804146685;4212.978935105336;4120;4158.397032430311;4160.271952408331;4162.961038441939;4207.453031105952;3967.543732470774;4084.100893084715;4134.4831896013;4160.687948403866;4178.916421671564;4152.356384760367;4154.273002224599;4158.916821663565;4164.333706606928;4166.66666666666;3727.9627203727887;3733.253349330145;3764.7741135531955;3776.773393596393;3785.470034195215;4913.010230856473;5130.820421285237;5163.296112282937;5171.301874246966;5172.689638621657;4805.183118869801;4826.058918510892;4829.3721816164025;4832.119559245188;4847.600437783284;5464.715791788926;5494.752736126884;5533.418991005967;5553.77784888608;5564.387917329091;4153.875383738493;4168.2080404723;4241.172971270604;4265.53079161292;4271.508776490712;5367.409584945653;5504.284443022421;5565;5593.832594716921;5599.61223459805;4912.336834527293;4956.306117143603;4963.51824087956;4988.5260900214425;5016.394753678787;5161.716105614152;5178.508041736029;5183.585313174937;5185.7329882174745;5187;5070.467600901852;5093.567046800989;5125.4874512549195;5200.323957885526;5214.009338225801;5472.50747432733;5473.562115030788;5473.972630136824;5496.395396506381;5496.560275177976;1715.682598719241;1738.8261173882763;1748.9212985415686;1757.8769486135848;1758.5515693498076;1353.580390079059;1406.8452470228267;1408.0917808013978;1414.6136785949827;1445.9083392038942;5375.16684913839;5392.91910621341;5410.188471729193;5475.67145971243;5477.04151773438;5615;5627.915581266284;5631.380548139701;5664.9803035454015;5668.7165641718575;5015.799368025238;5333.493318134771;5398.433164517748;5406.648567843077;5421.972890135603;2933.4866398380623;2942.3232656489126;2958.9704102959126;2976.300569366197;2996.7863015478765;5680.375158732536;5765.212784036962;5785.537157027512;5816.127580862904;5823.941760582425;5447.68473398804;5730;5735.885282294331;5740.425957404226;5756.30924289088;5752.252207212952;5790.9286781945475;5847.012015914609;5880.353161152269;5899.557533184942;5474.206240095244;5606.878624275243;5635.9436405635415;5675.57433192504;5683.7442315095095;5379.973100134474;5403.891922161613;5586.720663966704;5612.831615051555;5619.971900140473;5699.487046165865;5825.883482330414;5828.697664422444;5830.183774271521;5844.795432159854;4663.813447462064;4675.649326300609;4676.392069031004;4698.694584851974;4712.151812673752;5411.215373770702;5584.357798853184;5616.634918730269;5638.802641907513;5662.98963867821;5443.755031023535;5460.153676180198;5460.645058071213;5462.9726851365485;5492.368377636623;5359.598030147832;5489.478499542537;5501.257330260363;5509.47659972302;5522.22688823573;5414.399424382899;5433.239346491416;5462.863428414322;5470.234167216513;5488.506034456918;5475.288212532345;5477.424870388551;5490.80782172622;5541.03554598288;5541.833744987657;5238.842834714965;5316.973415132899;5345.625806193529;5392.433794451526;5431.538319242909 07:01:58 INFO - PROCESS | 3404 | |5;yui.html;905.5646799822281;943.9716808495745;946.3706635087667;946.5125460387898;966.8356379415496;17974.28102875885;18988;19044.61910761784;19078;19078.809211907894;16942.06818624975;17159.57101072474;17173.82826171738;17240;17255.309787608512;704.9541779784323;720.6216736213504;871.9084496127911;885.5882014863071;915.693242763675;912;916.5692124701379;918.2837386838277;921.6037104045258;921.6589861751162;963.5712108111893;963.6049219819876;964.9179819715332;965.6282331302464;966.2849491376367;738.8596166728305;757.1935888278992;926.5645146781002;948.1514044929818;953.6471505542925;693.826543364159;699.1819571101823;699.3426179391356;701.0430762009871;701.2251462134319;17681.823181768275;17924.462266132035;18013.639727205384;18183.36358227469;18196;15451.227438628024;15475.845241547553;15755.369785208577;15837.208139592974;16063.437779677655;14224.928875355557;14926.253687315591;14993;15241.16173610451;15297.770533442008;4940.6294527910195;5004.774785134678;5027.949720502785;5162.612804039674;5168.431472538018;82933;84468.15531844665;84832.15167848305;85400;85881.57059214664;13097.934510327388;13438.529651462348;13456.730865382833;13603.659908502366;13603.795943060863;24009.879950600134;24144.63783043256;24237.272881813573;24247.15134970303;24391.268261951816;9509;9534.475603841855;9555.474448905377;9601.279904007228;9689.224862011022;4848.612111031109;4937.7777999990085;5161.303224064778;5161.4322424533275;5269.868253293698;3803.657670809585;3888.494495715539;3892.1242720387686;3904.902377440587;3942.743721658083;672.314239475732;674.6592970549841;683.8871586188224;689.9896501552481;749.4341771962133;841.8947631546057;865.251557402842;874.4359887872287;886.763660584251;896.3546246702364;11768.646940591796;12258.632241032783;12375.6906077347;12595.181313214613;12879.678008049686;696.1611258433576;702.1363722621204;710.4884483172108;715.1882613234017;725.1950335128004;5341.626086174008;5737.110747834093;5761.135829625589;6048.42539958712;6348.523860710465;64540;66764.3323566758;71494.2850571498;72456;74005.62997184979;65472;65780;65868.67065664641;66119.66940165365;66344;58033;58628;58724;58954.41045589661;59289.110663340085;11734.354610496504;12417.62747117588;12495.187812792139;12507.812382814447;12725.300108494122;43086.78456607697;43729;43784.343234850865;43830.77037736267;44193.77903110464;46206.76896615495;47970.520294798;48258.27612585744;48730.75634621804;50308.74845625748;13918.51285205013;14612.926935365254;14679.266036697909;14710.41158353654;15062.32219550101;15870.365185392455;15990.680186395974;16001.279942402853;16064.759028614813;17023.319067237666;15991.360345586047;16534.503964881074;16769.245383957506;16879.07165105931;16947.237374318433;14959.626009349853;15143.772843407138;15201.92399038042;15903.284352203947;15965.361385544447;16104.516864494084;16149.75775363347;16909;16972.15139243008;17058.65882682364;11659.825102623297;11803.937645611935;12190;12338.3830808461;12544.372781361079;12923.547675831302;13086.14940028895;13124;13247.602571922473;13692.52076177329 07:01:58 INFO - PROCESS | 3404 | __end_tp_report 07:01:58 INFO - PROCESS | 3404 | __start_cc_report 07:01:58 INFO - PROCESS | 3404 | _x_x_mozilla_cycle_collect,1490 07:01:58 INFO - PROCESS | 3404 | __end_cc_report 07:01:58 INFO - PROCESS | 3404 | __startTimestamp1495202518469__endTimestamp 07:01:58 INFO - PROCESS | 3404 | 07:01:58 INFO - PROCESS | 3404 | ------- Summary: start ------- 07:01:58 INFO - PROCESS | 3404 | Number of tests: 6 07:01:58 INFO - PROCESS | 3404 | 07:01:58 INFO - PROCESS | 3404 | [#0] dojo.html Cycles:165 Average:5731.25 Median:5951.76 stddev:656.96 (11.0%) stddev-sans-first:631.67 07:01:58 INFO - PROCESS | 3404 | Values: 3342.0 3406.7 3430.2 3439.3 3469.3 5687.5 5795.4 5797.0 5803.3 5819.8 5741.3 5804.9 5811.7 5820.4 5826.7 5142.0 5170.7 5210.0 5217.9 5254.9 5029.8 5048.1 5244.9 5247.6 5255.6 5125.0 5148.9 5167.6 5168.3 5185.7 5256.8 5265.8 5267.0 5274.2 5297.1 5109.5 5155.0 5207.5 5222.4 5226.9 5585.1 5589.8 5646.9 5656.2 5756.6 6160.1 6184.2 6195.4 6198.4 6218.0 6252.7 6276.0 6277.2 6289.1 6291.7 5639.7 5689.1 5754.1 5783.8 5831.9 6387.8 6388.3 6390.0 6393.9 6399.3 6014.4 6111.0 6122.7 6123.4 6128.5 5972.2 6008.4 6179.1 6213.5 6220.5 6106.7 6109.2 6113.3 6132.6 6141.3 5937.2 5987.5 6136.8 6138.6 6149.1 4699.8 4716.0 4748.0 4772.0 4775.0 4134.0 4239.2 4251.4 4255.8 4270.8 5847.9 5918.5 5926.5 5943.3 5950.6 6264.4 6273.9 6285.4 6291.2 6296.6 5945.2 5953.0 5958.9 5987.6 6001.7 5123.2 5161.3 5165.1 5227.7 5254.2 6490.4 6492.4 6494.5 6507.2 6509.5 6232.9 6240.7 6284.2 6287.4 6297.8 6262.3 6285.0 6307.8 6320.1 6513.6 6059.2 6062.8 6066.1 6091.6 6110.5 6173.2 6211.0 6214.1 6216.9 6227.4 5835.3 5925.6 5940.1 6056.2 6102.5 5951.8 5962.5 5969.4 5975.3 5986.9 5959.6 5960.6 5961.2 5973.4 5979.0 5909.9 5930.9 5979.3 5980.2 5997.6 5902.8 5905.4 5907.8 5913.6 5915.9 07:01:58 INFO - PROCESS | 3404 | 07:01:58 INFO - PROCESS | 3404 | [#1] ext.html Cycles:180 Average:45740.19 Median:31065.27 stddev:77129.86 (248.3%) stddev-sans-first:77272.45 07:01:58 INFO - PROCESS | 3404 | Values: 809.0 836.2 846.3 921.1 923.9 30890.2 43473.8 44083.3 44190.6 44198.0 45636.8 45708.0 45746.8 45835.0 46094.5 7724.3 7907.0 9013.3 9147.0 9175.0 10622.6 10848.5 10851.1 10852.0 11238.4 10900.5 10954.1 10955.8 10955.8 10957.4 10809.1 10842.1 10855.7 10886.2 10919.7 10588.5 10646.5 10653.9 10654.4 10657.9 43361.0 43451.6 43506.3 43895.3 43935.3 4272.6 4318.7 4340.7 4420.6 4439.8 30289.1 30745.7 30982.7 31217.0 32033.4 4285.9 4411.8 4425.2 4458.1 4462.4 243094.0 243239.0 243498.0 243990.0 244071.0 47678.8 47724.8 47919.8 47947.5 47983.0 48123.5 48256.5 48285.8 48333.0 48377.5 15912.9 16306.0 16323.4 16323.7 16329.3 11011.1 11037.1 13790.3 14342.5 14379.1 12527.9 12608.4 12639.2 12645.4 12671.7 5314.7 5365.6 5425.7 5481.8 5530.8 1023.4 1026.7 1043.0 1044.5 1056.1 29278.0 29406.1 29453.6 29617.7 30054.1 1109.8 1116.3 1128.4 1130.2 1167.7 15388.5 17097.1 17166.5 18286.3 18335.3 327125.0 327894.0 327915.0 329002.0 329179.0 55747.0 55826.0 56027.4 56097.4 56137.0 1512.8 1514.9 1522.2 1547.6 1586.0 28721.7 29468.9 29635.4 30323.4 31147.8 39400.8 39551.8 39661.6 39683.6 39727.8 306548.0 307298.0 307476.0 307931.0 308035.0 25734.6 26239.7 29524.4 32061.5 32380.8 40783.2 41140.0 41248.4 41453.4 41802.4 31479.7 31615.5 31708.4 32025.5 32260.5 31447.7 31448.2 31521.5 31629.7 32272.0 35970.0 36206.0 36347.8 36412.3 36651.6 29914.9 30064.7 30446.8 30640.5 30869.5 23330.3 23985.3 24117.4 24343.0 24431.5 07:01:58 INFO - PROCESS | 3404 | 07:01:58 INFO - PROCESS | 3404 | [#2] jquery.html Cycles:180 Average:35513.61 Median:12563.04 stddev:97575.96 (776.7%) stddev-sans-first:97814.14 07:01:58 INFO - PROCESS | 3404 | Values: 435.6 445.7 452.8 456.2 482.7 20560.3 22313.6 22499.9 23262.3 23528.9 22793.5 23038.9 23156.4 23398.3 23664.5 6689.6 6763.6 6897.9 6931.3 6980.9 6624.7 6782.8 6906.7 6907.2 6915.3 6793.7 6847.6 6852.1 6856.5 6858.1 6759.1 6763.9 6807.5 6826.7 6851.4 6659.1 6694.2 6709.0 6710.0 6715.7 25990.9 26104.7 26137.7 26269.6 26584.7 3661.5 3724.7 3739.9 3788.0 3821.0 16100.0 17205.6 17341.0 17629.5 18024.5 2213.9 2282.2 2297.2 2318.9 2386.2 81125.0 91399.0 91857.5 94074.1 95249.5 18495.4 18598.9 18711.2 18811.0 18834.2 33843.3 34597.1 34607.8 34672.3 35214.5 11438.0 11504.3 11688.6 11703.7 11707.3 9770.4 9780.8 9781.0 9794.6 9931.9 10204.6 10250.5 10271.0 10466.2 10548.2 3567.4 3579.8 3791.9 3867.8 4003.4 978.8 987.2 990.6 993.9 1018.9 22190.2 22442.8 22587.2 22715.8 22828.9 1013.4 1013.5 1022.8 1023.4 1030.2 12017.0 12933.9 13036.3 13091.1 13230.8 490393.0 515749.0 627846.0 653462.0 657855.0 79614.0 101470.0 115008.4 118333.0 124719.0 1287.3 1371.5 1396.8 1416.4 1473.7 19297.3 19542.3 20034.8 20035.0 20037.1 51817.0 51883.2 52330.5 52503.7 53334.2 68556.0 68709.7 69539.0 69579.3 70675.0 13093.1 13131.3 13368.3 13425.1 13822.9 14092.2 14435.3 14572.9 14573.3 14816.4 12910.9 12997.4 13027.7 13117.3 13188.3 11595.1 11803.1 11938.5 11962.6 12383.3 12937.0 12948.8 13273.7 13325.5 13377.8 13315.5 13322.7 13326.6 13477.5 13480.6 12324.9 12537.4 12624.2 12648.6 12899.9 07:01:58 INFO - PROCESS | 3404 | 07:01:58 INFO - PROCESS | 3404 | [#3] mootools.html Cycles:180 Average:7126.32 Median:2527.29 stddev:4450.21 (176.1%) stddev-sans-first:4443.01 07:01:58 INFO - PROCESS | 3404 | Values: 1556.0 1558.1 1576.1 1583.0 1595.9 10641.0 11318.7 11318.9 11324.2 11328.4 10809.5 11226.7 11247.1 11249.9 11250.2 2521.8 2555.6 2558.5 2563.0 2564.1 2454.8 2490.9 2524.8 2529.7 2529.9 2416.6 2473.6 2549.2 2555.4 2561.4 2365.8 2417.6 2423.2 2493.0 2508.3 2402.8 2402.9 2442.4 2444.4 2447.7 11637.8 11701.4 11704.8 11767.6 11794.5 5915.8 6079.2 6086.1 6090.3 6091.3 3405.6 3492.2 3549.6 3740.3 3814.8 1399.1 1422.3 1447.6 2354.6 2387.2 14826.3 15185.8 17063.1 17578.0 17794.2 4587.4 4704.4 4819.3 4825.5 4843.8 12802.0 12813.0 12838.4 12847.1 12852.4 5914.6 5928.9 5929.3 5929.9 5933.0 5425.5 5533.5 5539.2 5545.0 5605.2 4068.1 4101.2 4126.5 4144.3 4163.5 1064.6 1066.7 1070.4 1086.7 1089.0 871.4 873.1 900.6 943.6 1109.5 7266.9 7313.6 7348.0 7438.3 7490.4 1073.2 1085.7 1087.1 1118.5 1145.2 4456.2 4486.5 4609.1 4625.5 4691.6 14334.1 14836.6 14880.6 14904.4 14915.9 14367.9 14615.5 14857.0 14895.4 14902.5 8927.0 10613.0 10856.6 10911.1 10918.6 6390.3 7264.3 7398.7 7486.7 7594.6 11897.6 12002.8 12003.7 12406.4 12553.4 12597.7 12725.0 12755.9 12836.7 12852.9 9239.5 9311.2 9395.8 9417.2 9423.3 10776.3 10816.5 10844.2 10859.8 10863.3 9147.8 9230.6 9245.5 9280.3 9364.9 9032.7 9159.3 9162.9 9307.4 9324.3 8566.3 8625.7 8665.0 8728.7 8772.7 6380.0 6405.8 6440.5 6572.7 6646.6 6224.3 6404.5 6409.6 6414.0 6532.3 07:01:58 INFO - PROCESS | 3404 | 07:01:58 INFO - PROCESS | 3404 | [#4] prototype.html Cycles:180 Average:4762.71 Median:5322.84 stddev:1272.58 (23.9%) stddev-sans-first:1233.67 07:01:58 INFO - PROCESS | 3404 | Values: 418.5 421.2 421.6 421.8 424.1 5301.9 5305.9 5314.6 5328.7 5342.5 4980.0 5005.5 5188.8 5223.6 5256.3 4111.5 4189.9 4208.6 4209.6 4213.0 4120.0 4158.4 4160.3 4163.0 4207.5 3967.5 4084.1 4134.5 4160.7 4178.9 4152.4 4154.3 4158.9 4164.3 4166.7 3728.0 3733.3 3764.8 3776.8 3785.5 4913.0 5130.8 5163.3 5171.3 5172.7 4805.2 4826.1 4829.4 4832.1 4847.6 5464.7 5494.8 5533.4 5553.8 5564.4 4153.9 4168.2 4241.2 4265.5 4271.5 5367.4 5504.3 5565.0 5593.8 5599.6 4912.3 4956.3 4963.5 4988.5 5016.4 5161.7 5178.5 5183.6 5185.7 5187.0 5070.5 5093.6 5125.5 5200.3 5214.0 5472.5 5473.6 5474.0 5496.4 5496.6 1715.7 1738.8 1748.9 1757.9 1758.6 1353.6 1406.8 1408.1 1414.6 1445.9 5375.2 5392.9 5410.2 5475.7 5477.0 5615.0 5627.9 5631.4 5665.0 5668.7 5015.8 5333.5 5398.4 5406.6 5422.0 2933.5 2942.3 2959.0 2976.3 2996.8 5680.4 5765.2 5785.5 5816.1 5823.9 5447.7 5730.0 5735.9 5740.4 5756.3 5752.3 5790.9 5847.0 5880.4 5899.6 5474.2 5606.9 5635.9 5675.6 5683.7 5380.0 5403.9 5586.7 5612.8 5620.0 5699.5 5825.9 5828.7 5830.2 5844.8 4663.8 4675.6 4676.4 4698.7 4712.2 5411.2 5584.4 5616.6 5638.8 5663.0 5443.8 5460.2 5460.6 5463.0 5492.4 5359.6 5489.5 5501.3 5509.5 5522.2 5414.4 5433.2 5462.9 5470.2 5488.5 5475.3 5477.4 5490.8 5541.0 5541.8 5238.8 5317.0 5345.6 5392.4 5431.5 07:01:58 INFO - PROCESS | 3404 | 07:01:58 INFO - PROCESS | 3404 | [#5] yui.html Cycles:180 Average:18333.21 Median:47088.64 stddev:21346.12 (45.3%) stddev-sans-first:21365.88 07:01:58 INFO - PROCESS | 3404 | Values: 905.6 944.0 946.4 946.5 966.8 17974.3 18988.0 19044.6 19078.0 19078.8 16942.1 17159.6 17173.8 17240.0 17255.3 705.0 720.6 871.9 885.6 915.7 912.0 916.6 918.3 921.6 921.7 963.6 963.6 964.9 965.6 966.3 738.9 757.2 926.6 948.2 953.6 693.8 699.2 699.3 701.0 701.2 17681.8 17924.5 18013.6 18183.4 18196.0 15451.2 15475.8 15755.4 15837.2 16063.4 14224.9 14926.3 14993.0 15241.2 15297.8 4940.6 5004.8 5027.9 5162.6 5168.4 82933.0 84468.2 84832.2 85400.0 85881.6 13097.9 13438.5 13456.7 13603.7 13603.8 24009.9 24144.6 24237.3 24247.2 24391.3 9509.0 9534.5 9555.5 9601.3 9689.2 4848.6 4937.8 5161.3 5161.4 5269.9 3803.7 3888.5 3892.1 3904.9 3942.7 672.3 674.7 683.9 690.0 749.4 841.9 865.3 874.4 886.8 896.4 11768.6 12258.6 12375.7 12595.2 12879.7 696.2 702.1 710.5 715.2 725.2 5341.6 5737.1 5761.1 6048.4 6348.5 64540.0 66764.3 71494.3 72456.0 74005.6 65472.0 65780.0 65868.7 66119.7 66344.0 58033.0 58628.0 58724.0 58954.4 59289.1 11734.4 12417.6 12495.2 12507.8 12725.3 43086.8 43729.0 43784.3 43830.8 44193.8 46206.8 47970.5 48258.3 48730.8 50308.7 13918.5 14612.9 14679.3 14710.4 15062.3 15870.4 15990.7 16001.3 16064.8 17023.3 15991.4 16534.5 16769.2 16879.1 16947.2 14959.6 15143.8 15201.9 15903.3 15965.4 16104.5 16149.8 16909.0 16972.2 17058.7 11659.8 11803.9 12190.0 12338.4 12544.4 12923.5 13086.1 13124.0 13247.6 13692.5 07:01:58 INFO - PROCESS | 3404 | -------- Summary: end -------- 07:01:58 INFO - PROCESS | 3404 | 07:01:59 INFO - TEST-INFO | 3404: exit 0 07:01:59 INFO - TEST-OK | dromaeo_css | took 1116794ms 07:01:59 INFO - TEST-START | kraken 07:01:59 INFO - operating with platform_type : linux_ 07:01:59 INFO - Initialising browser for kraken test... 07:01:59 INFO - TEST-INFO | started process 3710 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeBFpAd/profile http://localhost:59600/getInfo.html) 07:02:03 INFO - PROCESS | 3710 | __metrics Screen width/height:1600/1200 07:02:03 INFO - PROCESS | 3710 | colorDepth:24 07:02:03 INFO - PROCESS | 3710 | Browser inner width/height: 1024/697 07:02:03 INFO - PROCESS | 3710 | __metrics 07:02:03 INFO - PROCESS | 3710 | 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" 07:02:03 INFO - PROCESS | 3710 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:02:04 INFO - TEST-INFO | 3710: exit 0 07:02:04 INFO - Browser initialized. 07:02:04 INFO - Running cycle 1/1 for kraken test... 07:02:04 INFO - TEST-INFO | started process 3801 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeBFpAd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:02:16 INFO - PROCESS | 3801 | RSS: Main: 141459456 07:02:16 INFO - PROCESS | 3801 | 07:02:19 INFO - PROCESS | 3801 | Cycle 1(1): loaded http://localhost:59600/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59600/tests/kraken/driver.html?testName=audio-beat-detection) 07:02:19 INFO - PROCESS | 3801 | RSS: Main: 183418880 07:02:19 INFO - PROCESS | 3801 | 07:02:22 INFO - PROCESS | 3801 | Cycle 1(1): loaded http://localhost:59600/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59600/tests/kraken/driver.html?testName=audio-dft) 07:02:23 INFO - PROCESS | 3801 | RSS: Main: 173682688 07:02:23 INFO - PROCESS | 3801 | 07:02:25 INFO - PROCESS | 3801 | Cycle 1(1): loaded http://localhost:59600/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59600/tests/kraken/driver.html?testName=audio-fft) 07:02:26 INFO - PROCESS | 3801 | RSS: Main: 265097216 07:02:26 INFO - PROCESS | 3801 | 07:02:28 INFO - PROCESS | 3801 | Cycle 1(1): loaded http://localhost:59600/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59600/tests/kraken/driver.html?testName=audio-oscillator) 07:02:29 INFO - PROCESS | 3801 | RSS: Main: 171466752 07:02:29 INFO - PROCESS | 3801 | 07:02:31 INFO - PROCESS | 3801 | Cycle 1(1): loaded http://localhost:59600/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59600/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:02:31 INFO - PROCESS | 3801 | RSS: Main: 173768704 07:02:31 INFO - PROCESS | 3801 | 07:02:34 INFO - PROCESS | 3801 | Cycle 1(1): loaded http://localhost:59600/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59600/tests/kraken/driver.html?testName=imaging-darkroom) 07:02:35 INFO - PROCESS | 3801 | RSS: Main: 212090880 07:02:35 INFO - PROCESS | 3801 | 07:02:38 INFO - PROCESS | 3801 | Cycle 1(1): loaded http://localhost:59600/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59600/tests/kraken/driver.html?testName=imaging-desaturate) 07:02:39 INFO - PROCESS | 3801 | RSS: Main: 212058112 07:02:39 INFO - PROCESS | 3801 | 07:02:41 INFO - PROCESS | 3801 | Cycle 1(1): loaded http://localhost:59600/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59600/tests/kraken/driver.html?testName=json-parse-financial) 07:02:42 INFO - PROCESS | 3801 | RSS: Main: 211247104 07:02:42 INFO - PROCESS | 3801 | 07:02:44 INFO - PROCESS | 3801 | Cycle 1(1): loaded http://localhost:59600/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59600/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:02:44 INFO - PROCESS | 3801 | RSS: Main: 173285376 07:02:44 INFO - PROCESS | 3801 | 07:02:46 INFO - PROCESS | 3801 | Cycle 1(1): loaded http://localhost:59600/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59600/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:02:46 INFO - PROCESS | 3801 | RSS: Main: 179847168 07:02:46 INFO - PROCESS | 3801 | 07:02:48 INFO - PROCESS | 3801 | Cycle 1(1): loaded http://localhost:59600/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59600/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:02:49 INFO - PROCESS | 3801 | RSS: Main: 189980672 07:02:49 INFO - PROCESS | 3801 | 07:02:52 INFO - PROCESS | 3801 | Cycle 1(1): loaded http://localhost:59600/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59600/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:02:52 INFO - PROCESS | 3801 | RSS: Main: 198627328 07:02:52 INFO - PROCESS | 3801 | 07:02:55 INFO - PROCESS | 3801 | Cycle 1(1): loaded http://localhost:59600/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59600/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:02:56 INFO - PROCESS | 3801 | RSS: Main: 195260416 07:02:56 INFO - PROCESS | 3801 | 07:02:57 INFO - PROCESS | 3801 | Cycle 1(1): loaded http://localhost:59600/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59600/tests/kraken/driver.html?testName=ai-astar) 07:02:57 INFO - PROCESS | 3801 | RSS: Main: 246308864 07:02:57 INFO - PROCESS | 3801 | 07:02:57 INFO - PROCESS | 3801 | __start_tp_report 07:02:57 INFO - PROCESS | 3801 | _x_x_mozilla_page_load 07:02:57 INFO - PROCESS | 3801 | _x_x_mozilla_page_load_details 07:02:57 INFO - PROCESS | 3801 | |i|pagename|runs| 07:02:57 INFO - PROCESS | 3801 | |0;ai-astar;102;114;113;110;113;112;113;111;110;110 07:02:57 INFO - PROCESS | 3801 | |1;audio-beat-detection;138;119;115;149;121;120;123;114;131;117 07:02:57 INFO - PROCESS | 3801 | |2;audio-dft;162;161;162;161;159;159;161;159;160;161 07:02:57 INFO - PROCESS | 3801 | |3;audio-fft;74;75;75;112;75;75;77;74;90;75 07:02:57 INFO - PROCESS | 3801 | |4;audio-oscillator;83;82;101;81;83;83;109;82;82;111 07:02:57 INFO - PROCESS | 3801 | |5;imaging-gaussian-blur;113;113;113;113;113;112;113;113;113;114 07:02:57 INFO - PROCESS | 3801 | |6;imaging-darkroom;147;148;146;146;146;146;147;146;146;147 07:02:57 INFO - PROCESS | 3801 | |7;imaging-desaturate;93;93;94;93;94;94;94;94;94;94 07:02:57 INFO - PROCESS | 3801 | |8;json-parse-financial;57;55;54;54;54;55;56;56;56;53 07:02:57 INFO - PROCESS | 3801 | |9;json-stringify-tinderbox;52;53;52;52;52;52;53;52;53;52 07:02:57 INFO - PROCESS | 3801 | |10;stanford-crypto-aes;91;75;79;76;80;76;75;75;84;75 07:02:57 INFO - PROCESS | 3801 | |11;stanford-crypto-ccm;123;131;128;119;118;120;131;119;159;119 07:02:57 INFO - PROCESS | 3801 | |12;stanford-crypto-pbkdf2;157;157;157;156;157;159;164;156;159;159 07:02:57 INFO - PROCESS | 3801 | |13;stanford-crypto-sha256-iterative;61;60;59;60;59;59;59;59;59;58 07:02:57 INFO - PROCESS | 3801 | __end_tp_report 07:02:57 INFO - PROCESS | 3801 | __start_cc_report 07:02:57 INFO - PROCESS | 3801 | _x_x_mozilla_cycle_collect,1659 07:02:57 INFO - PROCESS | 3801 | __end_cc_report 07:02:57 INFO - PROCESS | 3801 | __startTimestamp1495202577924__endTimestamp 07:02:57 INFO - PROCESS | 3801 | 07:02:57 INFO - PROCESS | 3801 | ------- Summary: start ------- 07:02:57 INFO - PROCESS | 3801 | Number of tests: 14 07:02:57 INFO - PROCESS | 3801 | 07:02:57 INFO - PROCESS | 3801 | [#0] ai-astar Cycles:10 Average:110.80 Median:112.50 stddev:3.43 (3.0%) stddev-sans-first:1.56 07:02:57 INFO - PROCESS | 3801 | Values: 102.0 114.0 113.0 110.0 113.0 112.0 113.0 111.0 110.0 110.0 07:02:57 INFO - PROCESS | 3801 | 07:02:57 INFO - PROCESS | 3801 | [#1] audio-beat-detection Cycles:10 Average:124.70 Median:122.00 stddev:11.28 (9.2%) stddev-sans-first:10.89 07:02:57 INFO - PROCESS | 3801 | Values: 138.0 119.0 115.0 149.0 121.0 120.0 123.0 114.0 131.0 117.0 07:02:57 INFO - PROCESS | 3801 | 07:02:57 INFO - PROCESS | 3801 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:1.18 (0.7%) stddev-sans-first:1.12 07:02:57 INFO - PROCESS | 3801 | Values: 162.0 161.0 162.0 161.0 159.0 159.0 161.0 159.0 160.0 161.0 07:02:57 INFO - PROCESS | 3801 | 07:02:57 INFO - PROCESS | 3801 | [#3] audio-fft Cycles:10 Average:80.20 Median:75.00 stddev:12.15 (16.2%) stddev-sans-first:12.68 07:02:57 INFO - PROCESS | 3801 | Values: 74.0 75.0 75.0 112.0 75.0 75.0 77.0 74.0 90.0 75.0 07:02:57 INFO - PROCESS | 3801 | 07:02:57 INFO - PROCESS | 3801 | [#4] audio-oscillator Cycles:10 Average:89.70 Median:82.00 stddev:12.21 (14.9%) stddev-sans-first:12.71 07:02:57 INFO - PROCESS | 3801 | Values: 83.0 82.0 101.0 81.0 83.0 83.0 109.0 82.0 82.0 111.0 07:02:57 INFO - PROCESS | 3801 | 07:02:57 INFO - PROCESS | 3801 | [#5] imaging-gaussian-blur Cycles:10 Average:113.00 Median:113.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 07:02:57 INFO - PROCESS | 3801 | Values: 113.0 113.0 113.0 113.0 113.0 112.0 113.0 113.0 113.0 114.0 07:02:57 INFO - PROCESS | 3801 | 07:02:57 INFO - PROCESS | 3801 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 07:02:57 INFO - PROCESS | 3801 | Values: 147.0 148.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 147.0 07:02:57 INFO - PROCESS | 3801 | 07:02:57 INFO - PROCESS | 3801 | [#7] imaging-desaturate Cycles:10 Average:93.70 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 07:02:57 INFO - PROCESS | 3801 | Values: 93.0 93.0 94.0 93.0 94.0 94.0 94.0 94.0 94.0 94.0 07:02:57 INFO - PROCESS | 3801 | 07:02:57 INFO - PROCESS | 3801 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.50 stddev:1.25 (2.2%) stddev-sans-first:1.09 07:02:57 INFO - PROCESS | 3801 | Values: 57.0 55.0 54.0 54.0 54.0 55.0 56.0 56.0 56.0 53.0 07:02:57 INFO - PROCESS | 3801 | 07:02:57 INFO - PROCESS | 3801 | [#9] json-stringify-tinderbox Cycles:10 Average:52.30 Median:52.00 stddev:0.48 (0.9%) stddev-sans-first:0.50 07:02:57 INFO - PROCESS | 3801 | Values: 52.0 53.0 52.0 52.0 52.0 52.0 53.0 52.0 53.0 52.0 07:02:57 INFO - PROCESS | 3801 | 07:02:57 INFO - PROCESS | 3801 | [#10] stanford-crypto-aes Cycles:10 Average:78.60 Median:77.50 stddev:5.27 (6.8%) stddev-sans-first:3.15 07:02:57 INFO - PROCESS | 3801 | Values: 91.0 75.0 79.0 76.0 80.0 76.0 75.0 75.0 84.0 75.0 07:02:57 INFO - PROCESS | 3801 | 07:02:57 INFO - PROCESS | 3801 | [#11] stanford-crypto-ccm Cycles:10 Average:126.70 Median:125.50 stddev:12.45 (9.9%) stddev-sans-first:13.13 07:02:57 INFO - PROCESS | 3801 | Values: 123.0 131.0 128.0 119.0 118.0 120.0 131.0 119.0 159.0 119.0 07:02:57 INFO - PROCESS | 3801 | 07:02:57 INFO - PROCESS | 3801 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.10 Median:158.00 stddev:2.38 (1.5%) stddev-sans-first:2.49 07:02:57 INFO - PROCESS | 3801 | Values: 157.0 157.0 157.0 156.0 157.0 159.0 164.0 156.0 159.0 159.0 07:02:57 INFO - PROCESS | 3801 | 07:02:57 INFO - PROCESS | 3801 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.30 Median:59.00 stddev:0.82 (1.4%) stddev-sans-first:0.60 07:02:57 INFO - PROCESS | 3801 | Values: 61.0 60.0 59.0 60.0 59.0 59.0 59.0 59.0 59.0 58.0 07:02:57 INFO - PROCESS | 3801 | -------- Summary: end -------- 07:02:57 INFO - PROCESS | 3801 | 07:02:59 INFO - TEST-INFO | 3801: exit 0 07:02:59 INFO - TEST-OK | kraken | took 59899ms 07:02:59 INFO - SUITE-END | took 1176s 07:02:59 INFO - Completed test suite (00:19:37) 07:02:59 INFO - javascript benchmark 07:02:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7924.851964483932, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3341.966580334197, 3406.6763657452548, 3430.193904432458, 3439.3293307804956, 3469.2714529948707, 5687.544996400288, 5795.449432303935, 5797.043487824514, 5803.303603567572, 5819.7963071292515, 5741.311042674874, 5804.941950580493, 5811.651300921948, 5820.3597604263605, 5826.650400975934, 5142.0, 5170.741462926858, 5209.973950130244, 5217.921731174036, 5254.947450525484, 5029.84910452687, 5048.091343558158, 5244.895102097956, 5247.632665713401, 5255.579553635719, 5124.974375128119, 5148.8712782180555, 5167.586593072564, 5168.302279192318, 5185.662931909414, 5256.763445644955, 5265.842024739264, 5266.973665131688, 5274.208868669692, 5297.099493086184, 5109.540141387256, 5155.0, 5207.531322181022, 5222.399424066243, 5226.8693282667855, 5585.106382978704, 5589.832305030855, 5646.887062258732, 5656.151577263402, 5756.597038207327, 6160.1375807387, 6184.226971628546, 6195.411435913581, 6198.442140207403, 6218.005119180954, 6252.6561039142825, 6276.027215781562, 6277.2153480814895, 6289.119523266746, 6291.6854157291955, 5639.68981706006, 5689.089745640677, 5754.108113242454, 5783.826485205451, 5831.88336233273, 6387.776427825004, 6388.329225431356, 6390.0, 6393.904091438632, 6399.328070552618, 6014.368491308437, 6111.0, 6122.663253521099, 6123.357047509948, 6128.4790792783115, 5972.163897054415, 6008.429199226067, 6179.073139029181, 6213.502919766408, 6220.502359811204, 6106.703146374829, 6109.175261339751, 6113.32428171423, 6132.63204207749, 6141.324454310023, 5937.198478205473, 5987.461128498456, 6136.764169924236, 6138.600990935575, 6149.13912052313, 4699.835505757351, 4716.0, 4748.0, 4772.045590881838, 4774.976125119421, 4134.049168691218, 4239.173361194599, 4251.3622956556765, 4255.787210639518, 4270.7864606769535, 5847.9415205848245, 5918.526517878559, 5926.525877929842, 5943.31651860033, 5950.642961422329, 6264.436200741955, 6273.8745225095245, 6285.371462853769, 6291.182146321041, 6296.622202667854, 5945.167676525203, 5953.047512397996, 5958.910616340759, 5987.550933679991, 6001.729922153426, 5123.231515272739, 5161.3032240647035, 5165.070287348238, 5227.712475813867, 5254.15933450646, 6490.448311893542, 6492.448141907897, 6494.545381823227, 6507.21913370408, 6509.4792416605615, 6232.906506402498, 6240.719167637377, 6284.151639528605, 6287.371262873676, 6297.842553936188, 6262.3111457738705, 6284.968575157095, 6307.842303942254, 6320.051992201206, 6513.576617519846, 6059.242594675666, 6062.787802426894, 6066.1204125402455, 6091.573589848668, 6110.450059494667, 6173.228346456693, 6211.0, 6214.098955651315, 6216.875662486635, 6227.439530442282, 5835.270591176103, 5925.555583331181, 5940.108983652487, 6056.182415373868, 6102.4812890902995, 5951.7619295227705, 5962.522998160223, 5969.432903874125, 5975.342712301556, 5986.9401305986385, 5959.553033522589, 5960.5827592068135, 5961.165436838759, 5973.372795856372, 5979.043353063489, 5909.881802364014, 5930.940690593039, 5979.3123790762875, 5980.192673988956, 5997.5501837363245, 5902.793402230901, 5905.40945905406, 5907.793227237026, 5913.615614985012, 5915.881682366415], "value": 5687.293460640167, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [808.9555074470906, 836.1794256113504, 846.3229416466827, 921.0743203080903, 923.8891333040036, 30890.227744306376, 43473.78263108684, 44083.33874991874, 44190.558094419044, 44198.0, 45636.77181614087, 45708.0, 45746.7712661437, 45835.0, 46094.53905460944, 7724.266194711493, 7906.960465197666, 9013.32400069994, 9146.954265228698, 9175.0, 10622.62820801272, 10848.511816968215, 10851.131909447226, 10852.0, 11238.381888996142, 10900.454977251145, 10954.068904143158, 10955.780884382308, 10955.83566246507, 10957.397343146124, 10809.135269178447, 10842.132629389629, 10855.728606784893, 10886.183536234774, 10919.672409827677, 10588.470576471145, 10646.467676616216, 10653.893461065367, 10654.360738355723, 10657.946710266398, 43361.0, 43451.56548434507, 43506.347404788954, 43895.34156987648, 43935.340969885474, 4272.572742725733, 4318.654507639381, 4340.696151269412, 4420.602145806893, 4439.822407103712, 30289.09132726022, 30745.69254307473, 30982.690173098206, 31217.0, 32033.359332813212, 4285.892852678708, 4411.845585404528, 4425.181341451809, 4458.1306645204195, 4462.352958820953, 243094.0, 243239.0, 243498.0, 243990.0, 244071.0, 47678.76160619175, 47724.761376192895, 47919.76040119777, 47947.52052479431, 47983.0, 48123.5187648126, 48256.517434825204, 48285.75857120692, 48333.03333933372, 48377.5162248373, 15912.92043539775, 16306.0, 16323.428679996143, 16323.673526529403, 16329.265183066553, 11011.064059555027, 11037.11703063753, 13790.310484475936, 14342.49801256951, 14379.137251764927, 12527.874721252852, 12608.369581520887, 12639.1784534005, 12645.43095560702, 12671.746565068832, 5314.707691077027, 5365.570754339644, 5425.701586412706, 5481.808136715275, 5530.778768849201, 1023.4319952426475, 1026.6560702164709, 1042.968710938673, 1044.4516628769804, 1056.102313033915, 29278.0, 29406.11781646554, 29453.55819662707, 29617.703822961495, 30054.098377048722, 1109.7503061811028, 1116.3023110555903, 1128.4132251229478, 1130.1919127823646, 1167.6788883057056, 15388.538343849703, 17097.145142742815, 17166.485005449857, 18286.268549257882, 18335.266589336276, 327125.0, 327894.0, 327915.0, 329002.0, 329179.0, 55747.0, 55826.0, 56027.43972560222, 56097.43902561004, 56137.0, 1512.7655213441933, 1514.9318280677396, 1522.2160587297328, 1547.636305468214, 1585.9762103568455, 28721.71278287274, 29468.852655736584, 29635.407291854473, 30323.393532128794, 31147.844260779457, 39400.802995984835, 39551.80224098861, 39661.60338396579, 39683.60316396799, 39727.80136099301, 306548.0, 307298.0, 307476.0, 307931.0, 308035.0, 25734.613980790677, 26239.73760262373, 29524.409511810074, 32061.51907721433, 32380.83809580937, 40783.184336312515, 41140.0, 41248.38127428151, 41453.378199327635, 41802.37296440495, 31479.685203147674, 31615.525767113053, 31708.365832682757, 32025.519617205293, 32260.516092258167, 31447.685523145392, 31448.213794654403, 31521.52717709282, 31629.683703162675, 32272.0, 35970.0, 36206.0, 36347.81826090853, 36412.27175456423, 36651.633483665886, 29914.850425747733, 30064.699353007065, 30446.84776576103, 30640.540391894585, 30869.536956946115, 23330.28907242659, 23985.28044158678, 24117.397065073514, 24343.0, 24431.51136977286], "value": 18848.115378240243, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [435.5709626018373, 445.68133784344207, 452.7622997926088, 456.1993701054649, 482.7369083849302, 20560.280390186348, 22313.553728925453, 22499.887500562494, 23262.3021309361, 23528.88235558824, 22793.544129117407, 23038.88480557599, 23156.42108947273, 23398.298051058453, 23664.5267094658, 6689.632070236135, 6763.560368576052, 6897.896531552031, 6931.341522555349, 6980.895286570705, 6624.675064987022, 6782.762603308885, 6906.723731050777, 6907.171139463271, 6915.273896240898, 6793.728250869959, 6847.554908930929, 6852.109225800664, 6856.485763567753, 6858.074159988388, 6759.053732477457, 6763.864722705567, 6807.455403567703, 6826.69279882404, 6851.417629501499, 6659.067730517731, 6694.230163531208, 6708.9664551677415, 6710.0, 6715.731370745164, 25990.87004564965, 26104.73895261061, 26137.73862261372, 26269.605955910676, 26584.73415265842, 3661.521554523187, 3724.7206459515646, 3739.8691045813266, 3787.9810600947094, 3820.9808950955066, 16100.0, 17205.569860753458, 17341.0, 17629.471115866418, 18024.459266222035, 2213.944651383712, 2282.201229569654, 2297.1959814064944, 2318.9188378406843, 2386.248331775485, 81125.0, 91399.0, 91857.54071229669, 94074.05925940721, 95249.52375238079, 18495.352662656744, 18598.907005465157, 18711.157997890128, 18811.0, 18834.15246313919, 33843.323133537684, 34597.13507162341, 34607.82696086504, 34672.30655386878, 35214.471782923276, 11438.0, 11504.25222360544, 11688.590899318484, 11703.707407314714, 11707.2975621463, 9770.413775173512, 9780.804383912282, 9780.95109524462, 9794.559244834, 9931.900680993098, 10204.642837500653, 10250.538725757358, 10271.0, 10466.162706983423, 10548.156147508182, 3567.375709250871, 3579.8031108288774, 3791.9241615168094, 3867.7872717000837, 4003.4395184674167, 978.7993461340408, 987.195435719886, 990.6136606723384, 993.8707967964118, 1018.8930162332848, 22190.223342182948, 22442.775572244394, 22587.20944766925, 22715.772842271697, 22828.885855570617, 1013.3717095400899, 1013.5084484025242, 1022.8107800057013, 1023.4166525080782, 1030.1810061001522, 12017.0, 12933.935330323287, 13036.348182591022, 13091.08362414641, 13230.801537976939, 490393.0, 515749.0, 627846.0, 653462.0, 657855.0, 79614.0, 101470.0, 115008.42495787636, 118332.99999999828, 124719.0, 1287.304855378104, 1371.4788380415378, 1396.832380114393, 1416.3767942105442, 1473.7199932013098, 19297.324593639154, 19542.31601893927, 20034.799652003876, 20035.0, 20037.098330574867, 51817.0, 51883.221751673, 52330.47669523256, 52503.737481312346, 53334.19998699945, 68556.0, 68709.65645171743, 69539.0, 69579.30420695728, 70675.0, 13093.083484156017, 13131.277779722206, 13368.264745439094, 13425.127366721132, 13822.861771382157, 14092.154470731788, 14435.278236088363, 14572.927135364256, 14573.271336433349, 14816.40734370613, 12910.870891290966, 12997.415116319977, 13027.674308142372, 13117.278549679477, 13188.274644894624, 11595.130365222474, 11803.055755539364, 11938.52245910154, 11962.581309654468, 12383.318917459626, 12937.0, 12948.8057679133, 13273.734525309634, 13325.533606323732, 13377.799333009818, 13315.467381305027, 13322.666933326744, 13326.600201993955, 13477.46090156422, 13480.595582132551, 12324.876751232732, 12537.373131343578, 12624.17942833713, 12648.620541383772, 12899.871001289866], "value": 11842.732353048883, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1555.9844401555981, 1558.127448628768, 1576.1252504859801, 1582.9841701582984, 1595.880308976827, 10641.0, 11318.717032074203, 11318.886811131886, 11324.15068869835, 11328.433578321092, 10809.513571889263, 11226.719332016704, 11247.100231981442, 11249.887501124986, 11250.156238282141, 2521.848689078661, 2555.5527782638055, 2558.539462896678, 2562.9871850640816, 2564.1025641025676, 2454.828162028659, 2490.9252722418355, 2524.835885667426, 2529.747025297474, 2529.886155123024, 2416.613341865302, 2473.5671257529953, 2549.222487141421, 2555.3611597100726, 2561.398071453207, 2365.7989070928993, 2417.601095819188, 2423.212455951814, 2492.962605560918, 2508.3102146909746, 2402.7957623602015, 2402.9399265018515, 2442.364985103868, 2444.4499987502845, 2447.7185123710824, 11637.767244655144, 11701.414929253504, 11704.765904681859, 11767.646970590897, 11794.528218871235, 5915.763369465216, 6079.20970273866, 6086.056661217474, 6090.26916769986, 6091.329953705089, 3405.6083550391527, 3492.231709024011, 3549.6095429502734, 3740.3080430120244, 3814.828332725034, 1399.1465206224195, 1422.3315041930275, 1447.5886011139055, 2354.6114891042957, 2387.188355958965, 14826.258687065603, 15185.772213416807, 17063.146842657818, 17578.0, 17794.199261033285, 4587.357769912215, 4704.411948506437, 4819.325294458778, 4825.4933232010835, 4843.75781210938, 12802.0, 12813.0, 12838.42227099764, 12847.100702950891, 12852.357382130856, 5914.64512129265, 5928.911066334009, 5929.347771745104, 5929.911051334234, 5932.970335148383, 5425.484578964992, 5533.501984821305, 5539.169124631257, 5545.029619816516, 5605.187247849039, 4068.1058367420146, 4101.159262351211, 4126.504819421689, 4144.336906095071, 4163.458750362433, 1064.6167379743285, 1066.664000839733, 1070.4326706845384, 1086.7228856641507, 1089.003561741014, 871.4161511787117, 873.1486800369589, 900.5722281916169, 943.6366998705548, 1109.4896347680158, 7266.890996635055, 7313.634318284065, 7347.963260183665, 7438.326376565229, 7490.400767938552, 1073.2326386633595, 1085.7122862441458, 1087.0705546757408, 1118.5413980268213, 1145.1869172887343, 4456.24243878535, 4486.528914463999, 4609.101225261109, 4625.4911959684405, 4691.554302341272, 14334.068285561614, 14836.554903352917, 14880.62798430048, 14904.403823847142, 14915.850841491663, 14367.850571954219, 14615.488457903923, 14857.0, 14895.404183832525, 14902.478413255483, 8926.955365223132, 10613.0, 10856.565737370574, 10911.127109831194, 10918.617848375268, 6390.297067322498, 7264.273572642694, 7398.704051838082, 7486.663100160615, 7594.582297973665, 11897.583584574499, 12002.819957700816, 12003.699907502383, 12406.379681015733, 12553.435095420911, 12597.685057873627, 12725.0, 12755.93622031921, 12836.743265134832, 12852.871471285542, 9239.491827949527, 9311.208547273558, 9395.812083758423, 9417.199538039344, 9423.29325300619, 10776.29954052984, 10816.513256903616, 10844.24090313702, 10859.782804344028, 10863.348199108079, 9147.77130571741, 9230.630774768933, 9245.537723113683, 9280.303977201602, 9364.906350936404, 9032.729018129467, 9159.313051521029, 9162.862557061517, 9307.441553506811, 9324.347295689236, 8566.314694824523, 8625.69810056645, 8664.956675216836, 8728.65085396577, 8772.736817895473, 6380.0, 6405.807825765234, 6440.484761218998, 6572.704228309642, 6646.60120392778, 6224.346443623535, 6404.487640988803, 6409.551331406757, 6414.0, 6532.302319780494], "value": 5461.319503134167, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.5270644172085, 421.2081287180102, 421.59948049353085, 421.76591991444735, 424.1411142436568, 5301.867453313665, 5305.946940530594, 5314.627976041674, 5328.706921119337, 5342.545883599893, 4980.003999200157, 5005.522266478099, 5188.766505507252, 5223.582113430926, 5256.316678831747, 4111.5477297497255, 4189.916201675965, 4208.579142085782, 4209.6421804146685, 4212.978935105336, 4120.0, 4158.397032430311, 4160.271952408331, 4162.961038441939, 4207.453031105952, 3967.543732470774, 4084.100893084715, 4134.4831896013, 4160.687948403866, 4178.916421671564, 4152.356384760367, 4154.273002224599, 4158.916821663565, 4164.333706606928, 4166.66666666666, 3727.9627203727887, 3733.253349330145, 3764.7741135531955, 3776.773393596393, 3785.470034195215, 4913.010230856473, 5130.820421285237, 5163.296112282937, 5171.301874246966, 5172.689638621657, 4805.183118869801, 4826.058918510892, 4829.3721816164025, 4832.119559245188, 4847.600437783284, 5464.715791788926, 5494.752736126884, 5533.418991005967, 5553.77784888608, 5564.387917329091, 4153.875383738493, 4168.2080404723, 4241.172971270604, 4265.53079161292, 4271.508776490712, 5367.409584945653, 5504.284443022421, 5565.0, 5593.832594716921, 5599.61223459805, 4912.336834527293, 4956.306117143603, 4963.51824087956, 4988.5260900214425, 5016.394753678787, 5161.716105614152, 5178.508041736029, 5183.585313174937, 5185.7329882174745, 5187.0, 5070.467600901852, 5093.567046800989, 5125.4874512549195, 5200.323957885526, 5214.009338225801, 5472.50747432733, 5473.562115030788, 5473.972630136824, 5496.395396506381, 5496.560275177976, 1715.682598719241, 1738.8261173882763, 1748.9212985415686, 1757.8769486135848, 1758.5515693498076, 1353.580390079059, 1406.8452470228267, 1408.0917808013978, 1414.6136785949827, 1445.9083392038942, 5375.16684913839, 5392.91910621341, 5410.188471729193, 5475.67145971243, 5477.04151773438, 5615.0, 5627.915581266284, 5631.380548139701, 5664.9803035454015, 5668.7165641718575, 5015.799368025238, 5333.493318134771, 5398.433164517748, 5406.648567843077, 5421.972890135603, 2933.4866398380623, 2942.3232656489126, 2958.9704102959126, 2976.300569366197, 2996.7863015478765, 5680.375158732536, 5765.212784036962, 5785.537157027512, 5816.127580862904, 5823.941760582425, 5447.68473398804, 5730.0, 5735.885282294331, 5740.425957404226, 5756.30924289088, 5752.252207212952, 5790.9286781945475, 5847.012015914609, 5880.353161152269, 5899.557533184942, 5474.206240095244, 5606.878624275243, 5635.9436405635415, 5675.57433192504, 5683.7442315095095, 5379.973100134474, 5403.891922161613, 5586.720663966704, 5612.831615051555, 5619.971900140473, 5699.487046165865, 5825.883482330414, 5828.697664422444, 5830.183774271521, 5844.795432159854, 4663.813447462064, 4675.649326300609, 4676.392069031004, 4698.694584851974, 4712.151812673752, 5411.215373770702, 5584.357798853184, 5616.634918730269, 5638.802641907513, 5662.98963867821, 5443.755031023535, 5460.153676180198, 5460.645058071213, 5462.9726851365485, 5492.368377636623, 5359.598030147832, 5489.478499542537, 5501.257330260363, 5509.47659972302, 5522.22688823573, 5414.399424382899, 5433.239346491416, 5462.863428414322, 5470.234167216513, 5488.506034456918, 5475.288212532345, 5477.424870388551, 5490.80782172622, 5541.03554598288, 5541.833744987657, 5238.842834714965, 5316.973415132899, 5345.625806193529, 5392.433794451526, 5431.538319242909], "value": 4404.753752022875, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [905.5646799822281, 943.9716808495745, 946.3706635087667, 946.5125460387898, 966.8356379415496, 17974.28102875885, 18988.0, 19044.61910761784, 19078.0, 19078.809211907894, 16942.06818624975, 17159.57101072474, 17173.82826171738, 17240.0, 17255.309787608512, 704.9541779784323, 720.6216736213504, 871.9084496127911, 885.5882014863071, 915.693242763675, 912.0, 916.5692124701379, 918.2837386838277, 921.6037104045258, 921.6589861751162, 963.5712108111893, 963.6049219819876, 964.9179819715332, 965.6282331302464, 966.2849491376367, 738.8596166728305, 757.1935888278992, 926.5645146781002, 948.1514044929818, 953.6471505542925, 693.826543364159, 699.1819571101823, 699.3426179391356, 701.0430762009871, 701.2251462134319, 17681.823181768275, 17924.462266132035, 18013.639727205384, 18183.36358227469, 18196.0, 15451.227438628024, 15475.845241547553, 15755.369785208577, 15837.208139592974, 16063.437779677655, 14224.928875355557, 14926.253687315591, 14993.0, 15241.16173610451, 15297.770533442008, 4940.6294527910195, 5004.774785134678, 5027.949720502785, 5162.612804039674, 5168.431472538018, 82933.0, 84468.15531844665, 84832.15167848305, 85400.0, 85881.57059214664, 13097.934510327388, 13438.529651462348, 13456.730865382833, 13603.659908502366, 13603.795943060863, 24009.879950600134, 24144.63783043256, 24237.272881813573, 24247.15134970303, 24391.268261951816, 9509.0, 9534.475603841855, 9555.474448905377, 9601.279904007228, 9689.224862011022, 4848.612111031109, 4937.7777999990085, 5161.303224064778, 5161.4322424533275, 5269.868253293698, 3803.657670809585, 3888.494495715539, 3892.1242720387686, 3904.902377440587, 3942.743721658083, 672.314239475732, 674.6592970549841, 683.8871586188224, 689.9896501552481, 749.4341771962133, 841.8947631546057, 865.251557402842, 874.4359887872287, 886.763660584251, 896.3546246702364, 11768.646940591796, 12258.632241032783, 12375.6906077347, 12595.181313214613, 12879.678008049686, 696.1611258433576, 702.1363722621204, 710.4884483172108, 715.1882613234017, 725.1950335128004, 5341.626086174008, 5737.110747834093, 5761.135829625589, 6048.42539958712, 6348.523860710465, 64540.0, 66764.3323566758, 71494.2850571498, 72456.0, 74005.62997184979, 65472.0, 65780.0, 65868.67065664641, 66119.66940165365, 66344.0, 58033.0, 58628.0, 58724.0, 58954.41045589661, 59289.110663340085, 11734.354610496504, 12417.62747117588, 12495.187812792139, 12507.812382814447, 12725.300108494122, 43086.78456607697, 43729.0, 43784.343234850865, 43830.77037736267, 44193.77903110464, 46206.76896615495, 47970.520294798, 48258.27612585744, 48730.75634621804, 50308.74845625748, 13918.51285205013, 14612.926935365254, 14679.266036697909, 14710.41158353654, 15062.32219550101, 15870.365185392455, 15990.680186395974, 16001.279942402853, 16064.759028614813, 17023.319067237666, 15991.360345586047, 16534.503964881074, 16769.245383957506, 16879.07165105931, 16947.237374318433, 14959.626009349853, 15143.772843407138, 15201.92399038042, 15903.284352203947, 15965.361385544447, 16104.516864494084, 16149.75775363347, 16909.0, 16972.15139243008, 17058.65882682364, 11659.825102623297, 11803.937645611935, 12190.0, 12338.3830808461, 12544.372781361079, 12923.547675831302, 13086.14940028895, 13124.0, 13247.602571922473, 13692.52076177329], "value": 8110.793173177455, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1449.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 114.0, 113.0, 110.0, 113.0, 112.0, 113.0, 111.0, 110.0, 110.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 119.0, 115.0, 149.0, 121.0, 120.0, 123.0, 114.0, 131.0, 117.0], "value": 124.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 161.0, 159.0, 159.0, 161.0, 159.0, 160.0, 161.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 112.0, 75.0, 75.0, 77.0, 74.0, 90.0, 75.0], "value": 80.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 101.0, 81.0, 83.0, 83.0, 109.0, 82.0, 82.0, 111.0], "value": 89.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 113.0, 113.0, 112.0, 113.0, 113.0, 113.0, 114.0], "value": 113.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 93.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 54.0, 54.0, 54.0, 55.0, 56.0, 56.0, 56.0, 53.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 52.0, 52.0, 52.0, 52.0, 53.0, 52.0, 53.0, 52.0], "value": 52.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 75.0, 79.0, 76.0, 80.0, 76.0, 75.0, 75.0, 84.0, 75.0], "value": 78.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 131.0, 128.0, 119.0, 118.0, 120.0, 131.0, 119.0, 159.0, 119.0], "value": 126.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 157.0, 157.0, 156.0, 157.0, 159.0, 164.0, 156.0, 159.0, 159.0], "value": 158.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 59.0, 60.0, 59.0, 59.0, 59.0, 59.0, 59.0, 58.0], "value": 59.3, "unit": "score"}]}]} 07:02:59 INFO - Return code: 0 07:02:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:02:59 INFO - # TBPL SUCCESS # 07:02:59 INFO - Running post-action listener: _resource_record_post_action 07:02:59 INFO - [mozharness: 2017-05-19 14:02:59.742539Z] Finished run-tests step (success) 07:02:59 INFO - Running post-run listener: _resource_record_post_run 07:02:59 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 7745536; Write bytes: 334749696; Read time: 1932; Write time: 223620 07:02:59 INFO - TinderboxPrint: CPU usage
13.1% 07:02:59 INFO - TinderboxPrint: I/O read bytes / time
7,745,536 / 1,932 07:02:59 INFO - TinderboxPrint: I/O write bytes / time
334,749,696 / 223,620 07:02:59 INFO - TinderboxPrint: CPU idle
8,270.9 (86.9%) 07:02:59 INFO - TinderboxPrint: CPU user
1,197.8 (12.6%) 07:02:59 INFO - TinderboxPrint: Swap in / out
0 / 0 07:02:59 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 98111488; Read time: 0; Write time: 71032 07:02:59 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 5578752; Write bytes: 216358912; Read time: 1660; Write time: 148064 07:03:00 INFO - Running post-run listener: _upload_blobber_files 07:03:00 INFO - Blob upload gear active. 07:03:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:03:00 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 07:03:00 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'] 07:03:00 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 07:03:00 INFO - (blobuploader) - INFO - Open directory for files ... 07:03:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:03:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:03:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:03:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:03:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:03:01 INFO - (blobuploader) - INFO - Done attempting. 07:03:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:03:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:03:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:03:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:03:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:03:02 INFO - (blobuploader) - INFO - Done attempting. 07:03:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:03:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:03:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:03:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:03:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:03:06 INFO - (blobuploader) - INFO - Done attempting. 07:03:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:03:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:03:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:03:07 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:03:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:03:07 INFO - (blobuploader) - INFO - Done attempting. 07:03:07 INFO - (blobuploader) - INFO - Iteration through files over. 07:03:07 INFO - Return code: 0 07:03:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:03:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:03:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/84d8c2754ee5dc3b100c7e3bd2095cdbe747ee25843b0a42b302ad053a3e9e6fad2e3b81bb2f21a5ee7c203ed5516bc6e838e2c095abc9b7be0db53bdafb6852", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d3e4695818d9a2975d1199d3fa577a22979bcc93370fb73b80e2fa4525e499f36bef3600039cc3037732cdde64d0d35f7372cb169f349406de7d541076900cb4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1ee8896fe00e887e5e00dfa0258131c4587fb5aab6ca0fb242a3183f209b90b4ea005950104635467658d7ce94cf25884ebeac53e97ce78b8785797a6760d156", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4545a1aec8e9847508a9f6bc064d75f54da207dc15d1dd7e9c141f903d1ec0fcec8dde386f9ff936cc2ca82dce12835d8ce4f59dce12221eca9f9292979caab4"} 07:03:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:03:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:03:07 INFO - Contents: 07:03:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/84d8c2754ee5dc3b100c7e3bd2095cdbe747ee25843b0a42b302ad053a3e9e6fad2e3b81bb2f21a5ee7c203ed5516bc6e838e2c095abc9b7be0db53bdafb6852", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d3e4695818d9a2975d1199d3fa577a22979bcc93370fb73b80e2fa4525e499f36bef3600039cc3037732cdde64d0d35f7372cb169f349406de7d541076900cb4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1ee8896fe00e887e5e00dfa0258131c4587fb5aab6ca0fb242a3183f209b90b4ea005950104635467658d7ce94cf25884ebeac53e97ce78b8785797a6760d156", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4545a1aec8e9847508a9f6bc064d75f54da207dc15d1dd7e9c141f903d1ec0fcec8dde386f9ff936cc2ca82dce12835d8ce4f59dce12221eca9f9292979caab4"} 07:03:07 INFO - Running post-run listener: copy_logs_to_upload_dir 07:03:07 INFO - Copying logs to upload dir... 07:03:07 INFO - mkdir: /builds/slave/test/build/upload/logs 07:03:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.749309 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-05-19 07:03:07.070126) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-19 07:03:07.074555) ========= 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=51fc86400edbde9650d2781a000001d0-1495198785.892587-785134284 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/84d8c2754ee5dc3b100c7e3bd2095cdbe747ee25843b0a42b302ad053a3e9e6fad2e3b81bb2f21a5ee7c203ed5516bc6e838e2c095abc9b7be0db53bdafb6852", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d3e4695818d9a2975d1199d3fa577a22979bcc93370fb73b80e2fa4525e499f36bef3600039cc3037732cdde64d0d35f7372cb169f349406de7d541076900cb4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1ee8896fe00e887e5e00dfa0258131c4587fb5aab6ca0fb242a3183f209b90b4ea005950104635467658d7ce94cf25884ebeac53e97ce78b8785797a6760d156", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4545a1aec8e9847508a9f6bc064d75f54da207dc15d1dd7e9c141f903d1ec0fcec8dde386f9ff936cc2ca82dce12835d8ce4f59dce12221eca9f9292979caab4"} build_url:https://queue.taskcluster.net/v1/task/f5o6xQYfRqyfL35s8TINNQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011132 build_url: 'https://queue.taskcluster.net/v1/task/f5o6xQYfRqyfL35s8TINNQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/84d8c2754ee5dc3b100c7e3bd2095cdbe747ee25843b0a42b302ad053a3e9e6fad2e3b81bb2f21a5ee7c203ed5516bc6e838e2c095abc9b7be0db53bdafb6852", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d3e4695818d9a2975d1199d3fa577a22979bcc93370fb73b80e2fa4525e499f36bef3600039cc3037732cdde64d0d35f7372cb169f349406de7d541076900cb4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1ee8896fe00e887e5e00dfa0258131c4587fb5aab6ca0fb242a3183f209b90b4ea005950104635467658d7ce94cf25884ebeac53e97ce78b8785797a6760d156", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4545a1aec8e9847508a9f6bc064d75f54da207dc15d1dd7e9c141f903d1ec0fcec8dde386f9ff936cc2ca82dce12835d8ce4f59dce12221eca9f9292979caab4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-19 07:03:07.098364) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 07:03:07.098662) ========= 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=51fc86400edbde9650d2781a000001d0-1495198785.892587-785134284 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004434 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 07:03:07.181995) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-19 07:03:07.182296) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-19 07:03:07.185608) ========= ========= Total master_lag: 0.22 =========