builder: mozilla-beta_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-045 starttime: 1496054628.96 results: success (0) revision: 6fb66467485a8beee11dad38a08768c2a9955fe7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-29 03:43:48.958632) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-29 03:43:48.959068) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-29 03:43:48.959385) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-29 03:43:49.050774) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-29 03:43:49.051052) ========= 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=4300f881736b422476174874000001bc-1496039964.322098-380254487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-29 03:43:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 143M=0s 2017-05-29 03:43:49 (143 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.139017 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-29 03:43:49.221472) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-29 03:43:49.221802) ========= 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=4300f881736b422476174874000001bc-1496039964.322098-380254487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015668 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-29 03:43:49.291934) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-29 03:43:49.292307) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 6fb66467485a8beee11dad38a08768c2a9955fe7 --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 6fb66467485a8beee11dad38a08768c2a9955fe7 --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=4300f881736b422476174874000001bc-1496039964.322098-380254487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-29 03:43:50,099 truncating revision to first 12 chars 2017-05-29 03:43:50,099 Setting DEBUG logging. 2017-05-29 03:43:50,099 attempt 1/10 2017-05-29 03:43:50,099 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/6fb66467485a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-29 03:43:50,540 unpacking tar archive at: mozilla-beta-6fb66467485a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.856796 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-29 03:43:50.171661) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-29 03:43:50.171928) ========= script_repo_revision: 6fb66467485a8beee11dad38a08768c2a9955fe7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-29 03:43:50.172323) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-29 03:43:50.172592) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-29 03:43:50.194025) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-05-29 03:43:50.194298) ========= /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=4300f881736b422476174874000001bc-1496039964.322098-380254487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:43:51 INFO - MultiFileLogger online at 20170529 03:43:51 in /builds/slave/test 03:43:51 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 03:43:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:43:51 INFO - {'append_to_log': False, 03:43:51 INFO - 'base_work_dir': '/builds/slave/test', 03:43:51 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 03:43:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:43:51 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 03:43:51 INFO - 'buildbot_json_path': 'buildprops.json', 03:43:51 INFO - 'config_files': ('talos/linux_config.py',), 03:43:51 INFO - 'default_actions': ('clobber', 03:43:51 INFO - 'read-buildbot-config', 03:43:51 INFO - 'download-and-extract', 03:43:51 INFO - 'populate-webroot', 03:43:51 INFO - 'create-virtualenv', 03:43:51 INFO - 'install', 03:43:51 INFO - 'run-tests'), 03:43:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:43:51 INFO - 'download_minidump_stackwalk': True, 03:43:51 INFO - 'download_symbols': 'ondemand', 03:43:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:43:51 INFO - 'tooltool.py': '/tools/tooltool.py', 03:43:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:43:51 INFO - '/tools/misc-python/virtualenv.py')}, 03:43:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:43:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:43:51 INFO - 'gecko_profile': False, 03:43:51 INFO - 'gecko_profile_interval': 0, 03:43:51 INFO - 'installer_path': 'installer.exe', 03:43:51 INFO - 'log_level': 'info', 03:43:51 INFO - 'log_name': 'talos', 03:43:51 INFO - 'log_to_console': True, 03:43:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:43:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:43:51 INFO - 'opt_config_files': (), 03:43:51 INFO - 'pip_index': False, 03:43:51 INFO - 'suite': 'dromaeojs', 03:43:51 INFO - 'system_bits': '32', 03:43:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:43:51 INFO - 'title': 'talos-linux64-ix-045', 03:43:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:43:51 INFO - 'use_talos_json': True, 03:43:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:43:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:43:51 INFO - 'work_dir': 'build'} 03:43:51 INFO - [mozharness: 2017-05-29 10:43:51.097714Z] Running clobber step. 03:43:51 INFO - Running pre-action listener: _resource_record_pre_action 03:43:51 INFO - Running main action method: clobber 03:43:51 INFO - rmtree: /builds/slave/test/build 03:43:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:43:52 INFO - Running post-action listener: _resource_record_post_action 03:43:52 INFO - [mozharness: 2017-05-29 10:43:52.128410Z] Finished clobber step (success) 03:43:52 INFO - [mozharness: 2017-05-29 10:43:52.128510Z] Running read-buildbot-config step. 03:43:52 INFO - Running pre-action listener: _resource_record_pre_action 03:43:52 INFO - Running main action method: read_buildbot_config 03:43:52 INFO - Using buildbot properties: 03:43:52 INFO - { 03:43:52 INFO - "project": "", 03:43:52 INFO - "product": "firefox", 03:43:52 INFO - "who": "cbook@mozilla.com", 03:43:52 INFO - "installer_path": "public/build/target.tar.bz2", 03:43:52 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 03:43:52 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta/", 03:43:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs", 03:43:52 INFO - "stage_platform": "linux64", 03:43:52 INFO - "basedir": "/builds/slave/test", 03:43:52 INFO - "buildnumber": 61, 03:43:52 INFO - "platform": "ubuntu64_hw", 03:43:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:43:52 INFO - "slavebuilddir": "test", 03:43:52 INFO - "taskId": "cUGko2Y9QfuZbo3lxeYU9g", 03:43:52 INFO - "branch": "mozilla-beta", 03:43:52 INFO - "script_repo_revision": "production", 03:43:52 INFO - "revision": "6fb66467485a8beee11dad38a08768c2a9955fe7", 03:43:52 INFO - "slavename": "talos-linux64-ix-045", 03:43:52 INFO - "repo_path": "releases/mozilla-beta" 03:43:52 INFO - } 03:43:52 INFO - Finding installer, test and symbols from parent task. 03:43:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cUGko2Y9QfuZbo3lxeYU9g'}, attempt #1 03:43:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cUGko2Y9QfuZbo3lxeYU9g'}, attempt #1 03:43:53 INFO - Task dependencies: K20kuum8RaOnZ23O64rUIw 03:43:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K20kuum8RaOnZ23O64rUIw'}, attempt #1 03:43:53 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/K20kuum8RaOnZ23O64rUIw/artifacts/public/build/target.tar.bz2 03:43:53 INFO - Set test_url: https://queue.taskcluster.net/v1/task/K20kuum8RaOnZ23O64rUIw/artifacts/public/build/test_packages.json 03:43:53 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/K20kuum8RaOnZ23O64rUIw/artifacts/public/build/target.crashreporter-symbols.zip 03:43:53 INFO - Running post-action listener: _resource_record_post_action 03:43:53 INFO - [mozharness: 2017-05-29 10:43:53.477006Z] Finished read-buildbot-config step (success) 03:43:53 INFO - [mozharness: 2017-05-29 10:43:53.477258Z] Running download-and-extract step. 03:43:53 INFO - Running pre-action listener: _resource_record_pre_action 03:43:53 INFO - Running main action method: download_and_extract 03:43:53 INFO - mkdir: /builds/slave/test/build/tests 03:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:43:53 INFO - trying https://queue.taskcluster.net/v1/task/K20kuum8RaOnZ23O64rUIw/artifacts/public/build/target.test_packages.json 03:43:53 INFO - Downloading https://queue.taskcluster.net/v1/task/K20kuum8RaOnZ23O64rUIw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:43:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K20kuum8RaOnZ23O64rUIw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:43:54 INFO - Downloaded 986 bytes. 03:43:54 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:43:54 INFO - Using the following test package requirements: 03:43:54 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:43:54 INFO - u'common': [u'target.common.tests.zip'], 03:43:54 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:43:54 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:43:54 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:43:54 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:43:54 INFO - u'mozbase': [u'target.common.tests.zip'], 03:43:54 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:43:54 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:43:54 INFO - u'web-platform': [u'target.common.tests.zip', 03:43:54 INFO - u'target.web-platform.tests.zip'], 03:43:54 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:43:54 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:43:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K20kuum8RaOnZ23O64rUIw/artifacts/public/build/target.common.tests.zip 03:43:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K20kuum8RaOnZ23O64rUIw/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:43:54 INFO - Fetch https://queue.taskcluster.net/v1/task/K20kuum8RaOnZ23O64rUIw/artifacts/public/build/target.common.tests.zip into memory 03:43:57 INFO - Expected file size: 59712512 03:43:57 INFO - Obtained file size: 59712512 03:44:06 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:44:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K20kuum8RaOnZ23O64rUIw/artifacts/public/build/target.common.tests.zip 03:44:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K20kuum8RaOnZ23O64rUIw/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:44:06 INFO - Fetch https://queue.taskcluster.net/v1/task/K20kuum8RaOnZ23O64rUIw/artifacts/public/build/target.common.tests.zip into memory 03:44:08 INFO - Expected file size: 59712512 03:44:08 INFO - Obtained file size: 59712512 03:44:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K20kuum8RaOnZ23O64rUIw/artifacts/public/build/target.talos.tests.zip 03:44:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K20kuum8RaOnZ23O64rUIw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:44:19 INFO - Fetch https://queue.taskcluster.net/v1/task/K20kuum8RaOnZ23O64rUIw/artifacts/public/build/target.talos.tests.zip into memory 03:44:20 INFO - Expected file size: 14404461 03:44:20 INFO - Obtained file size: 14404461 03:44: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')]} 03:44:20 INFO - trying https://queue.taskcluster.net/v1/task/K20kuum8RaOnZ23O64rUIw/artifacts/public/build/target.tar.bz2 03:44:20 INFO - Downloading https://queue.taskcluster.net/v1/task/K20kuum8RaOnZ23O64rUIw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:44:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K20kuum8RaOnZ23O64rUIw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:44:22 INFO - Downloaded 59726839 bytes. 03:44:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K20kuum8RaOnZ23O64rUIw/artifacts/public/build/target.tar.bz2 03:44:22 INFO - mkdir: /builds/slave/test/properties 03:44:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:44:22 INFO - Writing to file /builds/slave/test/properties/build_url 03:44:22 INFO - Contents: 03:44:22 INFO - build_url:https://queue.taskcluster.net/v1/task/K20kuum8RaOnZ23O64rUIw/artifacts/public/build/target.tar.bz2 03:44:22 INFO - Running post-action listener: _resource_record_post_action 03:44:22 INFO - Running post-action listener: set_extra_try_arguments 03:44:22 INFO - [mozharness: 2017-05-29 10:44:22.650403Z] Finished download-and-extract step (success) 03:44:22 INFO - [mozharness: 2017-05-29 10:44:22.650629Z] Running populate-webroot step. 03:44:22 INFO - Running pre-action listener: _resource_record_pre_action 03:44:22 INFO - Running main action method: populate_webroot 03:44:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:44:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:44:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:44:22 INFO - '--tppagecycles', 03:44:22 INFO - '7'], 03:44:22 INFO - 'tests': ['tsvgm']}}, 03:44:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:44:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:44:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:44:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:44:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:44:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:44:22 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:44:22 INFO - 'talos_options': ['--disable-e10s'], 03:44:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:44:22 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:44:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:44:22 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:44:22 INFO - 'talos_options': ['--disable-e10s'], 03:44:22 INFO - 'tests': ['damp', 'tps']}, 03:44:22 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:44:22 INFO - 'tests': ['damp', 'tps']}, 03:44:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:44:22 INFO - 'tests': ['dromaeo_dom']}, 03:44:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:44:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:44:22 INFO - 'tests': ['basic_compositor_video']}, 03:44:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:44:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:44:22 INFO - 'tests': ['a11yr', 03:44:22 INFO - 'ts_paint', 03:44:22 INFO - 'tpaint', 03:44:22 INFO - 'sessionrestore', 03:44:22 INFO - 'sessionrestore_no_auto_restore', 03:44:22 INFO - 'tabpaint']}, 03:44:22 INFO - 'other-e10s': {'tests': ['a11yr', 03:44:22 INFO - 'ts_paint', 03:44:22 INFO - 'tpaint', 03:44:22 INFO - 'sessionrestore', 03:44:22 INFO - 'sessionrestore_no_auto_restore', 03:44:22 INFO - 'tabpaint']}, 03:44:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:44:22 INFO - 'ts_paint', 03:44:22 INFO - 'tpaint', 03:44:22 INFO - 'sessionrestore', 03:44:22 INFO - 'sessionrestore_no_auto_restore', 03:44:22 INFO - 'tabpaint']}, 03:44:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:44:22 INFO - 'ts_paint', 03:44:22 INFO - 'tpaint', 03:44:22 INFO - 'sessionrestore', 03:44:22 INFO - 'sessionrestore_no_auto_restore', 03:44:22 INFO - 'tabpaint']}, 03:44:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:44:22 INFO - 'tests': ['a11yr', 03:44:22 INFO - 'ts_paint', 03:44:22 INFO - 'tpaint', 03:44:22 INFO - 'sessionrestore', 03:44:22 INFO - 'sessionrestore_no_auto_restore', 03:44:22 INFO - 'tabpaint']}, 03:44:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:44:22 INFO - 'tests': ['a11yr', 03:44:22 INFO - 'ts_paint', 03:44:22 INFO - 'tpaint', 03:44:22 INFO - 'sessionrestore', 03:44:22 INFO - 'sessionrestore_no_auto_restore', 03:44:22 INFO - 'tabpaint']}, 03:44:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:44:22 INFO - 'tests': ['tsvgx', 03:44:22 INFO - 'tsvgr_opacity', 03:44:22 INFO - 'tart', 03:44:22 INFO - 'tscrollx', 03:44:22 INFO - 'cart', 03:44:22 INFO - 'tsvg_static']}, 03:44:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:44:22 INFO - 'tsvgr_opacity', 03:44:22 INFO - 'tart', 03:44:22 INFO - 'tscrollx', 03:44:22 INFO - 'cart', 03:44:22 INFO - 'tsvg_static']}, 03:44:22 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:44:22 INFO - 'talos_options': ['--disable-e10s'], 03:44:22 INFO - 'tests': ['tp5o']}, 03:44:22 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:44:22 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:44:22 INFO - 'talos_options': ['--disable-e10s', 03:44:22 INFO - '--xperf_path', 03:44:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:44:22 INFO - 'tests': ['tp5n']}, 03:44:22 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:44:22 INFO - 'talos_options': ['--xperf_path', 03:44:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:44:22 INFO - 'tests': ['tp5n']}}, 03:44:22 INFO - 'talos.zip': {'path': '', 03:44:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:44:22 INFO - Running post-action listener: _resource_record_post_action 03:44:22 INFO - [mozharness: 2017-05-29 10:44:22.667835Z] Finished populate-webroot step (success) 03:44:22 INFO - [mozharness: 2017-05-29 10:44:22.667925Z] Running create-virtualenv step. 03:44:22 INFO - Running pre-action listener: _resource_record_pre_action 03:44:22 INFO - Running main action method: create_virtualenv 03:44:22 INFO - Creating virtualenv /builds/slave/test/build/venv 03:44:22 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 03:44:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:44:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:44:22 INFO - Using real prefix '/usr' 03:44:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:44:23 INFO - Installing distribute.............................................................................................................................................................................................done. 03:44:25 INFO - Installing pip.................done. 03:44:25 INFO - Return code: 0 03:44:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:44:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:44:25 INFO - Reading from file tmpfile_stdout 03:44:25 INFO - Output received: 03:44:25 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) 03:44:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:44:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:44:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:44:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10eb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1129a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1389310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1386400>, '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 0x13873b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1387840>, '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': '4300f881736b422476174874000001bc-1496039964.322098-380254487', '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 03:44:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:44:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:44:25 INFO - Using env: {'DISPLAY': ':0', 03:44:25 INFO - 'HOME': '/home/cltbld', 03:44:25 INFO - 'LANG': 'en_US.UTF-8', 03:44:25 INFO - 'LANGUAGE': 'en_US:en', 03:44:25 INFO - 'LOGNAME': 'cltbld', 03:44:25 INFO - 'MAIL': '/var/mail/cltbld', 03:44:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:25 INFO - 'MOZ_NO_REMOTE': '1', 03:44:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:25 INFO - 'NO_EM_RESTART': '1', 03:44:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:25 INFO - 'PWD': '/builds/slave/test', 03:44:25 INFO - 'SHELL': '/bin/bash', 03:44:25 INFO - 'SHLVL': '1', 03:44:25 INFO - 'TERM': 'linux', 03:44:25 INFO - 'TMOUT': '86400', 03:44:25 INFO - 'USER': 'cltbld', 03:44:25 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1496039964.322098-380254487', 03:44:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:25 INFO - '_': '/tools/buildbot/bin/python'} 03:44:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:25 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 03:44:25 INFO - Cleaning up... 03:44:25 INFO - Return code: 0 03:44:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:44:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:44:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:44:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10eb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1129a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1389310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1386400>, '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 0x13873b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1387840>, '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': '4300f881736b422476174874000001bc-1496039964.322098-380254487', '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 03:44:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:44:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:44:25 INFO - Using env: {'DISPLAY': ':0', 03:44:25 INFO - 'HOME': '/home/cltbld', 03:44:25 INFO - 'LANG': 'en_US.UTF-8', 03:44:25 INFO - 'LANGUAGE': 'en_US:en', 03:44:25 INFO - 'LOGNAME': 'cltbld', 03:44:25 INFO - 'MAIL': '/var/mail/cltbld', 03:44:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:25 INFO - 'MOZ_NO_REMOTE': '1', 03:44:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:25 INFO - 'NO_EM_RESTART': '1', 03:44:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:25 INFO - 'PWD': '/builds/slave/test', 03:44:25 INFO - 'SHELL': '/bin/bash', 03:44:25 INFO - 'SHLVL': '1', 03:44:25 INFO - 'TERM': 'linux', 03:44:25 INFO - 'TMOUT': '86400', 03:44:25 INFO - 'USER': 'cltbld', 03:44:25 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1496039964.322098-380254487', 03:44:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:25 INFO - '_': '/tools/buildbot/bin/python'} 03:44:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:25 INFO - Downloading/unpacking psutil>=3.1.1 03:44:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:44:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:44:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:44:27 INFO - Installing collected packages: psutil 03:44:27 INFO - Running setup.py install for psutil 03:44:27 INFO - building 'psutil._psutil_linux' extension 03:44:27 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 03:44:27 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 03:44:27 INFO - building 'psutil._psutil_posix' extension 03:44:27 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 03:44:27 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 03:44:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:44:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:44:27 INFO - Successfully installed psutil 03:44:27 INFO - Cleaning up... 03:44:27 INFO - Return code: 0 03:44:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:44:27 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')]} 03:44:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:27 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')]} 03:44:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:27 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 0x10eb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1129a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1389310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1386400>, '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 0x13873b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1387840>, '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': '4300f881736b422476174874000001bc-1496039964.322098-380254487', '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 03:44:27 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 03:44:27 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 03:44:27 INFO - Using env: {'DISPLAY': ':0', 03:44:27 INFO - 'HOME': '/home/cltbld', 03:44:27 INFO - 'LANG': 'en_US.UTF-8', 03:44:27 INFO - 'LANGUAGE': 'en_US:en', 03:44:27 INFO - 'LOGNAME': 'cltbld', 03:44:27 INFO - 'MAIL': '/var/mail/cltbld', 03:44:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:27 INFO - 'MOZ_NO_REMOTE': '1', 03:44:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:27 INFO - 'NO_EM_RESTART': '1', 03:44:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:27 INFO - 'PWD': '/builds/slave/test', 03:44:27 INFO - 'SHELL': '/bin/bash', 03:44:27 INFO - 'SHLVL': '1', 03:44:27 INFO - 'TERM': 'linux', 03:44:27 INFO - 'TMOUT': '86400', 03:44:27 INFO - 'USER': 'cltbld', 03:44:27 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1496039964.322098-380254487', 03:44:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:27 INFO - '_': '/tools/buildbot/bin/python'} 03:44:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:44:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:44:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:44:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:44:28 INFO - Installing collected packages: mozsystemmonitor 03:44:28 INFO - Running setup.py install for mozsystemmonitor 03:44:29 INFO - Successfully installed mozsystemmonitor 03:44:29 INFO - Cleaning up... 03:44:29 INFO - Return code: 0 03:44:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:44:29 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')]} 03:44:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:29 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')]} 03:44:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:29 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 0x10eb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1129a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1389310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1386400>, '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 0x13873b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1387840>, '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': '4300f881736b422476174874000001bc-1496039964.322098-380254487', '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 03:44:29 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 03:44:29 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 03:44:29 INFO - Using env: {'DISPLAY': ':0', 03:44:29 INFO - 'HOME': '/home/cltbld', 03:44:29 INFO - 'LANG': 'en_US.UTF-8', 03:44:29 INFO - 'LANGUAGE': 'en_US:en', 03:44:29 INFO - 'LOGNAME': 'cltbld', 03:44:29 INFO - 'MAIL': '/var/mail/cltbld', 03:44:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:29 INFO - 'MOZ_NO_REMOTE': '1', 03:44:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:29 INFO - 'NO_EM_RESTART': '1', 03:44:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:29 INFO - 'PWD': '/builds/slave/test', 03:44:29 INFO - 'SHELL': '/bin/bash', 03:44:29 INFO - 'SHLVL': '1', 03:44:29 INFO - 'TERM': 'linux', 03:44:29 INFO - 'TMOUT': '86400', 03:44:29 INFO - 'USER': 'cltbld', 03:44:29 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1496039964.322098-380254487', 03:44:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:29 INFO - '_': '/tools/buildbot/bin/python'} 03:44:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:29 INFO - Downloading/unpacking jsonschema==2.5.1 03:44:29 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 03:44:29 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 03:44:29 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 03:44:29 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 03:44:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:44:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:44:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:30 INFO - Downloading functools32-3.2.3-2.tar.gz 03:44:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:44:30 INFO - warning: no files found matching '*.txt' 03:44:30 INFO - no previously-included directories found matching 'build' 03:44:30 INFO - no previously-included directories found matching 'dist' 03:44:30 INFO - no previously-included directories found matching '.git*' 03:44:30 INFO - Installing collected packages: jsonschema, functools32 03:44:30 INFO - Running setup.py install for functools32 03:44:30 INFO - warning: no files found matching '*.txt' 03:44:30 INFO - no previously-included directories found matching 'build' 03:44:30 INFO - no previously-included directories found matching 'dist' 03:44:30 INFO - no previously-included directories found matching '.git*' 03:44:30 INFO - Successfully installed jsonschema functools32 03:44:30 INFO - Cleaning up... 03:44:30 INFO - Return code: 0 03:44:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:44:30 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')]} 03:44:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:30 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')]} 03:44:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:30 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 0x10eb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1129a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1389310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1386400>, '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 0x13873b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1387840>, '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': '4300f881736b422476174874000001bc-1496039964.322098-380254487', '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 03:44:30 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 03:44:30 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 03:44:30 INFO - Using env: {'DISPLAY': ':0', 03:44:30 INFO - 'HOME': '/home/cltbld', 03:44:30 INFO - 'LANG': 'en_US.UTF-8', 03:44:30 INFO - 'LANGUAGE': 'en_US:en', 03:44:30 INFO - 'LOGNAME': 'cltbld', 03:44:30 INFO - 'MAIL': '/var/mail/cltbld', 03:44:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:30 INFO - 'MOZ_NO_REMOTE': '1', 03:44:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:30 INFO - 'NO_EM_RESTART': '1', 03:44:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:30 INFO - 'PWD': '/builds/slave/test', 03:44:30 INFO - 'SHELL': '/bin/bash', 03:44:30 INFO - 'SHLVL': '1', 03:44:30 INFO - 'TERM': 'linux', 03:44:30 INFO - 'TMOUT': '86400', 03:44:30 INFO - 'USER': 'cltbld', 03:44:30 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1496039964.322098-380254487', 03:44:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:30 INFO - '_': '/tools/buildbot/bin/python'} 03:44:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:44:30 INFO - Cleaning up... 03:44:31 INFO - Return code: 0 03:44:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:44:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:44:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:44:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:31 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 0x10eb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1129a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1389310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1386400>, '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 0x13873b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1387840>, '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': '4300f881736b422476174874000001bc-1496039964.322098-380254487', '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 03:44:31 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 03:44:31 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 03:44:31 INFO - Using env: {'DISPLAY': ':0', 03:44:31 INFO - 'HOME': '/home/cltbld', 03:44:31 INFO - 'LANG': 'en_US.UTF-8', 03:44:31 INFO - 'LANGUAGE': 'en_US:en', 03:44:31 INFO - 'LOGNAME': 'cltbld', 03:44:31 INFO - 'MAIL': '/var/mail/cltbld', 03:44:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:31 INFO - 'MOZ_NO_REMOTE': '1', 03:44:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:31 INFO - 'NO_EM_RESTART': '1', 03:44:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:31 INFO - 'PWD': '/builds/slave/test', 03:44:31 INFO - 'SHELL': '/bin/bash', 03:44:31 INFO - 'SHLVL': '1', 03:44:31 INFO - 'TERM': 'linux', 03:44:31 INFO - 'TMOUT': '86400', 03:44:31 INFO - 'USER': 'cltbld', 03:44:31 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1496039964.322098-380254487', 03:44:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:31 INFO - '_': '/tools/buildbot/bin/python'} 03:44:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:31 INFO - Downloading/unpacking blobuploader==1.2.4 03:44:31 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 03:44:31 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 03:44:31 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 03:44:31 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 03:44:32 INFO - Downloading blobuploader-1.2.4.tar.gz 03:44:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:44:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:44:32 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 03:44:32 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 03:44:32 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 03:44:32 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 03:44:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:44:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:44:32 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 03:44:32 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 03:44:32 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 03:44:32 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 03:44:32 INFO - Downloading docopt-0.6.1.tar.gz 03:44:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:44:32 INFO - Installing collected packages: blobuploader, requests, docopt 03:44:32 INFO - Running setup.py install for blobuploader 03:44:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:44:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:44:33 INFO - Running setup.py install for requests 03:44:33 INFO - Running setup.py install for docopt 03:44:33 INFO - Successfully installed blobuploader requests docopt 03:44:33 INFO - Cleaning up... 03:44:33 INFO - Return code: 0 03:44:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:44:33 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')]} 03:44:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:33 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')]} 03:44:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:33 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 0x10eb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1129a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1389310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1386400>, '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 0x13873b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1387840>, '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': '4300f881736b422476174874000001bc-1496039964.322098-380254487', '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 03:44:33 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 03:44:33 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 03:44:33 INFO - Using env: {'DISPLAY': ':0', 03:44:33 INFO - 'HOME': '/home/cltbld', 03:44:33 INFO - 'LANG': 'en_US.UTF-8', 03:44:33 INFO - 'LANGUAGE': 'en_US:en', 03:44:33 INFO - 'LOGNAME': 'cltbld', 03:44:33 INFO - 'MAIL': '/var/mail/cltbld', 03:44:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:33 INFO - 'MOZ_NO_REMOTE': '1', 03:44:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:33 INFO - 'NO_EM_RESTART': '1', 03:44:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:33 INFO - 'PWD': '/builds/slave/test', 03:44:33 INFO - 'SHELL': '/bin/bash', 03:44:33 INFO - 'SHLVL': '1', 03:44:33 INFO - 'TERM': 'linux', 03:44:33 INFO - 'TMOUT': '86400', 03:44:33 INFO - 'USER': 'cltbld', 03:44:33 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1496039964.322098-380254487', 03:44:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:33 INFO - '_': '/tools/buildbot/bin/python'} 03:44:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:44:33 INFO - Running setup.py (path:/tmp/pip-RcSq_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:44:33 INFO - Running setup.py (path:/tmp/pip-0Kdn4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:44:33 INFO - Running setup.py (path:/tmp/pip-bpquMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:44:33 INFO - Running setup.py (path:/tmp/pip-4UkDsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:44:34 INFO - Running setup.py (path:/tmp/pip-QE6NKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:44:34 INFO - Running setup.py (path:/tmp/pip-kVKi_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:44:34 INFO - Running setup.py (path:/tmp/pip-9OmFkM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:44:34 INFO - Running setup.py (path:/tmp/pip-L6e5HB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:44:34 INFO - Running setup.py (path:/tmp/pip-eB7NVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:44:34 INFO - Running setup.py (path:/tmp/pip-QjC8KI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:44:34 INFO - Running setup.py (path:/tmp/pip-bxPkMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:44:34 INFO - Running setup.py (path:/tmp/pip-vr0Vc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:44:34 INFO - Running setup.py (path:/tmp/pip-g6asFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:44:34 INFO - Running setup.py (path:/tmp/pip-V3tYMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:44:34 INFO - Running setup.py (path:/tmp/pip-3HEBQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:44:34 INFO - Running setup.py (path:/tmp/pip-6hddnE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:44:34 INFO - Running setup.py (path:/tmp/pip-pc_hy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:44:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:44:34 INFO - Running setup.py install for manifestparser 03:44:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:44:35 INFO - Running setup.py install for mozcrash 03:44:35 INFO - Running setup.py install for mozdebug 03:44:35 INFO - Running setup.py install for mozdevice 03:44:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:44:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:44:35 INFO - Running setup.py install for mozfile 03:44:35 INFO - Running setup.py install for mozhttpd 03:44:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:44:35 INFO - Running setup.py install for mozinfo 03:44:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:44:35 INFO - Running setup.py install for mozInstall 03:44:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:44:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:44:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:44:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:44:35 INFO - Running setup.py install for mozleak 03:44:35 INFO - Running setup.py install for mozlog 03:44:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:44:36 INFO - Running setup.py install for moznetwork 03:44:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:44:36 INFO - Running setup.py install for mozprocess 03:44:36 INFO - Running setup.py install for mozprofile 03:44:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:44:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:44:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:44:36 INFO - Running setup.py install for mozrunner 03:44:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:44:36 INFO - Running setup.py install for mozscreenshot 03:44:36 INFO - Running setup.py install for moztest 03:44:36 INFO - Running setup.py install for mozversion 03:44:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:44:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:44:36 INFO - Cleaning up... 03:44:36 INFO - Return code: 0 03:44:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:44:36 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')]} 03:44:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:36 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')]} 03:44:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:36 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 0x10eb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1129a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1389310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1386400>, '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 0x13873b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1387840>, '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': '4300f881736b422476174874000001bc-1496039964.322098-380254487', '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 03:44:36 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 03:44:36 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 03:44:36 INFO - Using env: {'DISPLAY': ':0', 03:44:36 INFO - 'HOME': '/home/cltbld', 03:44:36 INFO - 'LANG': 'en_US.UTF-8', 03:44:36 INFO - 'LANGUAGE': 'en_US:en', 03:44:36 INFO - 'LOGNAME': 'cltbld', 03:44:36 INFO - 'MAIL': '/var/mail/cltbld', 03:44:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:36 INFO - 'MOZ_NO_REMOTE': '1', 03:44:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:36 INFO - 'NO_EM_RESTART': '1', 03:44:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:36 INFO - 'PWD': '/builds/slave/test', 03:44:36 INFO - 'SHELL': '/bin/bash', 03:44:36 INFO - 'SHLVL': '1', 03:44:36 INFO - 'TERM': 'linux', 03:44:36 INFO - 'TMOUT': '86400', 03:44:36 INFO - 'USER': 'cltbld', 03:44:36 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1496039964.322098-380254487', 03:44:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:36 INFO - '_': '/tools/buildbot/bin/python'} 03:44:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:44:36 INFO - Running setup.py (path:/tmp/pip-Ok3k4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:44:37 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)) 03:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:44:37 INFO - Running setup.py (path:/tmp/pip-rv7zEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:44:37 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)) 03:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:44:37 INFO - Running setup.py (path:/tmp/pip-jmwvtq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:44:37 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)) 03:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:44:37 INFO - Running setup.py (path:/tmp/pip-UjaKW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:44:37 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)) 03:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:44:37 INFO - Running setup.py (path:/tmp/pip-baNPcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:44:37 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)) 03:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:44:37 INFO - Running setup.py (path:/tmp/pip-3moHu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:44:37 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)) 03:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:44:37 INFO - Running setup.py (path:/tmp/pip-3yZuGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:44:37 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)) 03:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:44:37 INFO - Running setup.py (path:/tmp/pip-80DHhL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:44:37 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)) 03:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:44:37 INFO - Running setup.py (path:/tmp/pip-fPKMlM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:44:37 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)) 03:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:44:37 INFO - Running setup.py (path:/tmp/pip-463pG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:44:37 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)) 03:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:44:37 INFO - Running setup.py (path:/tmp/pip-WQxt67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:44:37 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)) 03:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:44:37 INFO - Running setup.py (path:/tmp/pip-9wuEOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:44:37 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)) 03:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:44:37 INFO - Running setup.py (path:/tmp/pip-6j27dW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:44:37 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)) 03:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:44:37 INFO - Running setup.py (path:/tmp/pip-Bobakq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:44:38 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)) 03:44:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:44:38 INFO - Running setup.py (path:/tmp/pip-CLyRcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:44:38 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)) 03:44:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:44:38 INFO - Running setup.py (path:/tmp/pip-jLJ2NQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:44:38 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)) 03:44:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:44:38 INFO - Running setup.py (path:/tmp/pip-ZYVYJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:44:38 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)) 03:44:38 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)) 03:44:38 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)) 03:44:38 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)) 03:44:38 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)) 03:44:38 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)) 03:44:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:44:38 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 03:44:38 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 03:44:38 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 03:44:38 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 03:44:39 INFO - Downloading blessings-1.6.tar.gz 03:44:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:44:39 INFO - Installing collected packages: blessings 03:44:39 INFO - Running setup.py install for blessings 03:44:39 INFO - Successfully installed blessings 03:44:39 INFO - Cleaning up... 03:44:39 INFO - Return code: 0 03:44:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:44:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:44:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:44:39 INFO - Reading from file tmpfile_stdout 03:44:39 INFO - Current package versions: 03:44:39 INFO - argparse == 1.2.1 03:44:39 INFO - blessings == 1.6 03:44:39 INFO - blobuploader == 1.2.4 03:44:39 INFO - docopt == 0.6.1 03:44:39 INFO - functools32 == 3.2.3-2 03:44:39 INFO - jsonschema == 2.5.1 03:44:39 INFO - manifestparser == 1.1 03:44:39 INFO - mozInstall == 1.12 03:44:39 INFO - mozcrash == 1.0 03:44:39 INFO - mozdebug == 0.1 03:44:39 INFO - mozdevice == 0.49 03:44:39 INFO - mozfile == 1.2 03:44:39 INFO - mozhttpd == 0.7 03:44:39 INFO - mozinfo == 0.9 03:44:39 INFO - mozleak == 0.1 03:44:39 INFO - mozlog == 3.4 03:44:39 INFO - moznetwork == 0.27 03:44:39 INFO - mozprocess == 0.25 03:44:39 INFO - mozprofile == 0.28 03:44:39 INFO - mozrunner == 6.13 03:44:39 INFO - mozscreenshot == 0.1 03:44:39 INFO - mozsystemmonitor == 0.3 03:44:39 INFO - moztest == 0.8 03:44:39 INFO - mozversion == 1.4 03:44:39 INFO - psutil == 3.1.1 03:44:39 INFO - requests == 1.2.3 03:44:39 INFO - wsgiref == 0.1.2 03:44:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:44:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:44:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:44:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:39 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 0x10eb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1129a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1389310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1386400>, '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 0x13873b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1387840>, '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': '4300f881736b422476174874000001bc-1496039964.322098-380254487', '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 03:44:39 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 03:44:39 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 03:44:39 INFO - Using env: {'DISPLAY': ':0', 03:44:39 INFO - 'HOME': '/home/cltbld', 03:44:39 INFO - 'LANG': 'en_US.UTF-8', 03:44:39 INFO - 'LANGUAGE': 'en_US:en', 03:44:39 INFO - 'LOGNAME': 'cltbld', 03:44:39 INFO - 'MAIL': '/var/mail/cltbld', 03:44:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:39 INFO - 'MOZ_NO_REMOTE': '1', 03:44:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:39 INFO - 'NO_EM_RESTART': '1', 03:44:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:39 INFO - 'PWD': '/builds/slave/test', 03:44:39 INFO - 'SHELL': '/bin/bash', 03:44:39 INFO - 'SHLVL': '1', 03:44:39 INFO - 'TERM': 'linux', 03:44:39 INFO - 'TMOUT': '86400', 03:44:39 INFO - 'USER': 'cltbld', 03:44:39 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1496039964.322098-380254487', 03:44:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:39 INFO - '_': '/tools/buildbot/bin/python'} 03:44:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:40 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)) 03:44:40 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)) 03:44:40 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)) 03:44:40 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)) 03:44:40 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)) 03:44:40 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)) 03:44:40 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)) 03:44:40 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)) 03:44:40 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)) 03:44:40 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)) 03:44:40 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)) 03:44:40 INFO - Cleaning up... 03:44:40 INFO - Return code: 0 03:44:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:44:40 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')]} 03:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:40 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')]} 03:44:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:40 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 0x10eb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1129a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1389310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1386400>, '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 0x13873b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1387840>, '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': '4300f881736b422476174874000001bc-1496039964.322098-380254487', '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 03:44:40 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 03:44:40 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 03:44:40 INFO - Using env: {'DISPLAY': ':0', 03:44:40 INFO - 'HOME': '/home/cltbld', 03:44:40 INFO - 'LANG': 'en_US.UTF-8', 03:44:40 INFO - 'LANGUAGE': 'en_US:en', 03:44:40 INFO - 'LOGNAME': 'cltbld', 03:44:40 INFO - 'MAIL': '/var/mail/cltbld', 03:44:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:40 INFO - 'MOZ_NO_REMOTE': '1', 03:44:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:40 INFO - 'NO_EM_RESTART': '1', 03:44:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:40 INFO - 'PWD': '/builds/slave/test', 03:44:40 INFO - 'SHELL': '/bin/bash', 03:44:40 INFO - 'SHLVL': '1', 03:44:40 INFO - 'TERM': 'linux', 03:44:40 INFO - 'TMOUT': '86400', 03:44:40 INFO - 'USER': 'cltbld', 03:44:40 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1496039964.322098-380254487', 03:44:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:40 INFO - '_': '/tools/buildbot/bin/python'} 03:44:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:44:40 INFO - Cleaning up... 03:44:40 INFO - Return code: 0 03:44:40 INFO - Running post-action listener: _resource_record_post_action 03:44:40 INFO - Running post-action listener: _start_resource_monitoring 03:44:40 INFO - Starting resource monitoring. 03:44:40 INFO - [mozharness: 2017-05-29 10:44:40.288191Z] Finished create-virtualenv step (success) 03:44:40 INFO - [mozharness: 2017-05-29 10:44:40.288662Z] Running install step. 03:44:40 INFO - Running pre-action listener: _resource_record_pre_action 03:44:40 INFO - Running main action method: install 03:44:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:44:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:44:40 INFO - Reading from file tmpfile_stdout 03:44:40 INFO - Detecting whether we're running mozinstall >=1.0... 03:44:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:44:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:44:40 INFO - Reading from file tmpfile_stdout 03:44:40 INFO - Output received: 03:44:40 INFO - Usage: mozinstall [options] installer 03:44:40 INFO - Options: 03:44:40 INFO - -h, --help show this help message and exit 03:44:40 INFO - -d DEST, --destination=DEST 03:44:40 INFO - Directory to install application into. [default: 03:44:40 INFO - "/builds/slave/test"] 03:44:40 INFO - --app=APP Application being installed. [default: firefox] 03:44:40 INFO - mkdir: /builds/slave/test/build/application 03:44:40 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'] 03:44:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:44:54 INFO - Reading from file tmpfile_stdout 03:44:54 INFO - Output received: 03:44:54 INFO - /builds/slave/test/build/application/firefox/firefox 03:44:54 INFO - Running post-action listener: _resource_record_post_action 03:44:54 INFO - [mozharness: 2017-05-29 10:44:54.697589Z] Finished install step (success) 03:44:54 INFO - [mozharness: 2017-05-29 10:44:54.697834Z] Running run-tests step. 03:44:54 INFO - Running pre-action listener: _resource_record_pre_action 03:44:54 INFO - Running main action method: run_tests 03:44:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:44:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:44:54 INFO - Python 2.7.3 03:44:54 INFO - Return code: 0 03:44:54 INFO - grabbing minidump binary from tooltool 03:44: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')]} 03:44:54 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 0x1386400>, '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 0x13873b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1387840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:44:54 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 03:44:54 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 03:44:54 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 03:44:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:44:54 INFO - Return code: 0 03:44:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:44:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:44:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:44:54 INFO - ENV: RUST_BACKTRACE is now 1 03:44:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:44:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:44:54 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/K20kuum8RaOnZ23O64rUIw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 03:44:54 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/K20kuum8RaOnZ23O64rUIw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 03:44:54 INFO - Using env: {'DISPLAY': ':0', 03:44:54 INFO - 'HOME': '/home/cltbld', 03:44:54 INFO - 'LANG': 'en_US.UTF-8', 03:44:54 INFO - 'LANGUAGE': 'en_US:en', 03:44:54 INFO - 'LOGNAME': 'cltbld', 03:44:54 INFO - 'MAIL': '/var/mail/cltbld', 03:44:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:44:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:44:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:54 INFO - 'MOZ_NO_REMOTE': '1', 03:44:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:44:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:54 INFO - 'NO_EM_RESTART': '1', 03:44:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:54 INFO - 'PWD': '/builds/slave/test', 03:44:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:44:54 INFO - 'RUST_BACKTRACE': '1', 03:44:54 INFO - 'SHELL': '/bin/bash', 03:44:54 INFO - 'SHLVL': '1', 03:44:54 INFO - 'TERM': 'linux', 03:44:54 INFO - 'TMOUT': '86400', 03:44:54 INFO - 'USER': 'cltbld', 03:44:54 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1496039964.322098-380254487', 03:44:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:54 INFO - '_': '/tools/buildbot/bin/python'} 03:44:54 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/K20kuum8RaOnZ23O64rUIw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 03:44:54 INFO - mozversion application_buildid: 20170529094900 03:44:54 INFO - mozversion application_changeset: 6fb66467485a8beee11dad38a08768c2a9955fe7 03:44:54 INFO - mozversion application_display_name: Firefox 03:44:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:44:54 INFO - mozversion application_name: Firefox 03:44:54 INFO - mozversion application_remotingname: firefox 03:44:54 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 03:44:54 INFO - mozversion application_vendor: Mozilla 03:44:54 INFO - mozversion application_version: 54.0 03:44:54 INFO - mozversion platform_buildid: 20170529094900 03:44:54 INFO - mozversion platform_changeset: 6fb66467485a8beee11dad38a08768c2a9955fe7 03:44:54 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 03:44:54 INFO - mozversion platform_version: 54.0 03:44:54 INFO - using testdate: 1496054694 03:44:54 INFO - actual date: 1496054694 03:44:54 INFO - starting webserver on 'localhost:54007' 03:44:54 INFO - SUITE-START | Running 2 tests 03:44:54 INFO - TEST-START | dromaeo_css 03:44:54 INFO - operating with platform_type : linux_ 03:44:54 INFO - Initialising browser for dromaeo_css test... 03:44:54 INFO - TEST-INFO | started process 24228 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq7x9WU/profile http://localhost:54007/getInfo.html) 03:44:59 INFO - PROCESS | 24228 | __metrics Screen width/height:1600/1200 03:44:59 INFO - PROCESS | 24228 | colorDepth:24 03:44:59 INFO - PROCESS | 24228 | Browser inner width/height: 1024/697 03:44:59 INFO - PROCESS | 24228 | __metrics 03:45:00 INFO - PROCESS | 24228 | 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" 03:45:00 INFO - PROCESS | 24228 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:45:01 INFO - PROCESS | 24228 | console.error: PushService: 03:45:01 INFO - PROCESS | 24228 | stateChangeProcessEnqueue: Error transitioning state 03:45:01 INFO - PROCESS | 24228 | UnknownError 03:45:01 INFO - TEST-INFO | 24228: exit 0 03:45:01 INFO - Browser initialized. 03:45:01 INFO - Running cycle 1/1 for dromaeo_css test... 03:45:01 INFO - TEST-INFO | started process 24319 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq7x9WU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:45:13 INFO - PROCESS | 24319 | RSS: Main: 141778944 03:45:13 INFO - PROCESS | 24319 | 03:48:15 INFO - PROCESS | 24319 | Cycle 1(1): loaded http://localhost:54007/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54007/tests/dromaeo/cssquery-ext.html) 03:48:16 INFO - PROCESS | 24319 | RSS: Main: 256327680 03:48:16 INFO - PROCESS | 24319 | 03:51:18 INFO - PROCESS | 24319 | Cycle 1(1): loaded http://localhost:54007/tests/dromaeo/cssquery-ext.html (next: http://localhost:54007/tests/dromaeo/cssquery-jquery.html) 03:51:19 INFO - PROCESS | 24319 | RSS: Main: 234569728 03:51:19 INFO - PROCESS | 24319 | 03:54:20 INFO - PROCESS | 24319 | Cycle 1(1): loaded http://localhost:54007/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54007/tests/dromaeo/cssquery-mootools.html) 03:54:21 INFO - PROCESS | 24319 | RSS: Main: 175742976 03:54:21 INFO - PROCESS | 24319 | 03:57:23 INFO - PROCESS | 24319 | Cycle 1(1): loaded http://localhost:54007/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54007/tests/dromaeo/cssquery-prototype.html) 03:57:24 INFO - PROCESS | 24319 | RSS: Main: 172457984 03:57:24 INFO - PROCESS | 24319 | 04:00:26 INFO - PROCESS | 24319 | Cycle 1(1): loaded http://localhost:54007/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54007/tests/dromaeo/cssquery-yui.html) 04:00:27 INFO - PROCESS | 24319 | RSS: Main: 172064768 04:00:27 INFO - PROCESS | 24319 | 04:03:29 INFO - PROCESS | 24319 | Cycle 1(1): loaded http://localhost:54007/tests/dromaeo/cssquery-yui.html (next: http://localhost:54007/tests/dromaeo/cssquery-dojo.html) 04:03:30 INFO - PROCESS | 24319 | RSS: Main: 258703360 04:03:30 INFO - PROCESS | 24319 | 04:03:30 INFO - PROCESS | 24319 | __start_tp_report 04:03:30 INFO - PROCESS | 24319 | _x_x_mozilla_page_load 04:03:30 INFO - PROCESS | 24319 | _x_x_mozilla_page_load_details 04:03:30 INFO - PROCESS | 24319 | |i|pagename|runs| 04:03:30 INFO - PROCESS | 24319 | |0;dojo.html;3444.0356700123966;3484;3493.4410494320914;3510.2979404119183;3537.6285490023547;5766.394528574497;5838.737256823442;5842.240508733858;5874.089516124996;5877.67672777997;5830.183774271605;5850.151727999448;5875.206847075643;5878.1476685880525;5878.823635290937;5131.897362052766;5178.715170665612;5189.610779191576;5238.685678859261;5253.789848406078;5009.198528235483;5027.622928280375;5254.395744489375;5264.341957255343;5266.236395722618;5087.79648814047;5139.511746384088;5146.279520867063;5152.819651312205;5154.819581314655;5089.058524173021;5102.260172275;5107.310513080743;5110.080185566597;5115.18157094863;5066.873328166788;5125.077486052509;5159.071367153911;5160.0969830279555;5160.14857548504;5731.484166425042;5744.569157313218;5821.53427725781;5825.563082768809;5847.44449277318;6006.249218847644;6053.848653783647;6145.661988590626;6145.801568694106;6179.66011869347;6264.185655864754;6286.717097730613;6287.308396076428;6290.87418251637;6316.368363163693;5821.592488525847;5863.5309175265875;5865.090910908816;5867.413258674099;5878.911816322759;6057.242844644419;6080.726367313481;6276.121343011982;6304.306526282106;6396.232452105684;6145.66198859067;6165.5375846810775;6165.537584681167;6167.691615419211;6176.227971503562;6255.093011513305;6255.6872156392;6259.405356491126;6259.405356491126;6262.3111457739615;5887.911681324784;5947.5539334550085;6122.632642041492;6168.321484636686;6228.626282423069;6161.537884658668;6181.443670069715;6195.19462469876;6200.720967556471;6209.348018458088;4590.9540904591195;4620;4623.052274283764;4737.881552961135;4832.395950506187;4248.553901840324;4267.871963841089;4281.443412356436;4287.764172970454;4319.719218250803;5697.3448053474385;5818.33089194748;5895.734691938873;5971.5222782177325;6025.638461692312;6167.013277875608;6188.071789231652;6194.938050619527;6195.442410183015;6210.254769427697;5990.670513121733;5995.910061349084;5997.6401415914315;5998.430149135826;6019.879602407927;5149.304843846107;5349.893002140013;5357.732113394392;5359.678419294854;5362.436944120889;6236.844078898064;6304.936950630527;6362.840928976812;6372.330905254881;6381.585196962183;6299.559030867978;6300.149479820166;6307.779227727007;6312.084747711648;6313.43179113882;6386.16979792624;6402.583832051088;6432.453241474527;6444.8388790280615;6459.192600924885;5860.120981852756;5896.764129434946;6023.969880150571;6049.879002420015;6170.444659980623;6189.876202475835;6207.441330280297;6213.440790328892;6214.161088253028;6217.875642487215;6042.425969532887;6049.76710588594;6051.818445446644;6056.515478761777;6096.542759293159;5867.413258674269;5903.881922361615;5985.970070149621;5992.700364981821;6060.181875446759;6049.425304596057;6053.243344581927;6067.817965461043;6081.209442772411;6108;6091.939080609137;6101.816945491642;6109.908351374644;6116.785912493041;6120.204373431426;5749.913751293818;5793.275840519935;5874.177615133799;5880.029795083934;5933.080372542263 04:03:30 INFO - PROCESS | 24319 | |1;ext.html;766.1380946435261;807.4105902691036;826.7065191856891;906.1074841281337;914.6021480655911;31407.68592314076;45135;45589.54410455898;45881.541184588226;45992.31011534829;41660;41925;41932.371014434735;46022.309665355046;46145.307820382724;9137.680181193642;9278.489683067428;9281.303902207328;9284.953575232148;9289.489078100736;7715.768526944201;7899;10660.840087398696;10908.072813810835;10917.454127293644;10929;10950.288231264982;10975.890241097566;10977.341359518414;10981.945090274538;10831.970962758565;10861.40262285574;10875.45622718861;10892.891071089267;10905.127589792797;10596.470176491144;10641.840372394421;10685.198610104273;10688.198385121146;10698.679039628823;43889.12221755579;44122.117557648664;44123.558764412264;44169.77915110436;44190.33714494285;4311.245532031913;4338.436003319548;4363.716358436724;4463.308187230984;4474.127545128701;30661.693383066107;31718.841405793053;31900.521492177635;32119;32671;4374.671899607511;4408.493023302329;4491.8203271869415;4541.34150548172;4572.9314060289125;231069;231411;232115;232393;232577;54807;55100.448995509534;55425.722871385384;55574.16638750422;55850;57701.71149144227;58126.41873581295;58255.70872145697;58295;58345.124823127684;16798.328066877188;17056.31774728997;17068.573285667957;17109.828901711073;17125.91437042807;12185.390730463441;14888;14984.70030599382;15015;15024.924875375553;12566.183198092094;13750.449982000608;13950.651233719036;14070.437182512585;14580.708385832437;5288.206768984606;5333.759980800795;5346.224797404355;5448.645838020516;5467.835964921059;1022.9539670714836;1027.9588816447258;1034.332855308322;1038.4236748604446;1048.145761204631;28671.56992645112;29345.413091738046;30133;30239.697603023687;30493.847530762203;1302.218668798732;1306.5296493262417;1313.6940700206862;1314.8750868667462;1342.8052932324758;13799.396644144626;13990.650233744034;14074.71850562983;14133.78799318011;14377.56867293983;320942;320964;321971;322397;322717;49551;49640.25539616909;49642;49722.25416618754;49762.25356619654;1505.6913332766756;1510.2222355486933;1527.9236038198046;1529.3041666041925;1543.5137931551526;28523.42953140967;29325.26686832761;29711.85144074266;29847.850760746056;30288.69711302859;37555.248895022494;37839.43240851334;37878.8106059468;37920.241595168496;37939.81030094832;270842;271410;271730;271866;271876;30878.0736577903;30947;31047.68952310448;31531;31671.20821979469;40825.387619185145;41064.79467602643;41553.79223103865;41930.161396772506;42397.576024239366;32715.34569308648;32880.67119328776;33009.66990330066;33059.504107437926;33099.17252068718;32137.839310803298;32280.35439291248;32880.50679239861;33280.667193327754;33579.66420335766;36697.44953825641;37046;37523.81238093792;37759.433608496445;37790.244195116495;31163.53254701136;31267.687323126476;31320.686793131776;31642.525362120046;32442.188945276557;24857.502849943263;25341.87329063343;25473.03275861189;25549.61675574905;26076 04:03:30 INFO - PROCESS | 24319 | |2;jquery.html;471.48372532077406;474.7412660100245;487.4759633394102;488.379757707711;492.50257240187403;20616.587668246644;21512.247071352507;21903;22072;22094.226702065433;22183.556328873412;22569.54860902781;23047;23514.412139696473;23730;6623.5032372572;6666.966665166668;6794;6805.557638753465;6873.450123990069;6780.627065511395;6915.135608048994;7336.449766267525;7594.354479869217;7618.961905190494;7261.237570055147;7751.922480775176;7755.418343624223;7771.533707977539;7773.611319434034;7581.090269167707;7674.961625191839;7679.961600191991;7683.577403242847;7691.807704807425;7263.782086537412;7373.29953654402;7410.147832999221;7455.962720186419;7489.438292128058;25278.620820687705;25699;26099.478010439874;26190.607140892902;26621.201363959113;3139.199504126433;3184.9203769905707;3189.6331921829055;3197.328561002192;3244.6106467224085;16144.273507692182;16189.83810161895;16248.675026499523;16399.098049607266;16587.751183732253;2285.3600991722346;2322.3149170994598;2335.708036495438;2377.1798729438315;2418.830681852271;116187;120677;121164.39417802854;121767;122630.38684806519;17665.233476652487;17801;18356.816431835778;18513.166907489194;18688.34590789316;32209.194770130933;32431.189220269684;32442.351152976807;32468.350632987207;32710;10529.157667386591;10551.15590752738;10570;10718.946405267923;10734.087602553715;8892.955535222283;8923.375363724477;8937.508437036025;9140.63437462494;9155;8945.73162805117;9302.813943721088;9321.533923303808;9400.905990940004;9479.573419196153;3523.7709548879243;3540.345036168317;3732.6267373263;3741.540669570324;3877.263319969197;966.709987003896;979.6913972098766;983.2232536296389;985.4038306824411;1005.7133716890651;21476.677849832264;21652.35042948714;21772;21849.67225491619;21897.781022189574;1074.6292529077455;1093.223811094132;1111.5331560744507;1116.3413585984308;1132.932024078558;11274.154438416988;11301.547938082385;11641.126915481373;11825.113116516295;12356.567520136752;671574;704131;716677;718195;745028;86207.13792861991;97855;112783.43608281905;114489;117556;1319.6041187643668;1363.9659008524866;1386.7573174694387;1392.2273138408282;1393.958181254564;19358.032098395306;19426.125824337658;19581.314653987043;19683.901580492005;19762.70355944691;52200.738996304775;52740.20889686734;53137.46862531325;53391;53516.46483535115;62088.37911621007;67065;67532.66233668997;68573.65713171402;68801.65599171972;12839.743205136032;13358.198508089547;13455.932720336335;13463.528776492776;13547.322633868464;14684.926575367055;14700.41198352054;14874.405023798927;15013.099214047192;15017.249137543298;12863.099583029098;12897;12938.935305323414;13081.476740930257;13235.139715918434;11767;12054.939725301318;12233.510659573873;12321.260724356567;12363.93818030904;13006.80489792635;13112.803307950198;13213.207207567577;13225.867741322463;13235.536756213487;13238.602841914759;13309.134906231064;13434.798478023033;13440.93279533596;13532.188068715908;12746.298953557643;12833.807492887427;12967.481300748243;12970.22178669283;13298.468061277441 04:03:30 INFO - PROCESS | 24319 | |3;mootools.html;1442.156338541953;1603.7113319602468;1612.1455628516887;1625.3336132185807;1628.6254161542845;9643.421394716323;11191.608293709722;11434.7141321467;11907.16649834512;11930.701732456693;11687.123465740062;11727.237729547594;11738.882611173885;11743.588974385899;11746.295222286668;2548.541262572741;2591.300348905794;2592.844429334246;2594.0531705927297;2597.4025974025985;2071.099071903719;2136.2202795979433;2501.962470562943;2565.307367010906;2573.3180707112538;2419.9274021779374;2430.3924018995253;2445.5475736988715;2447.706275246973;2450.767177118171;2525.229804909502;2529.0895277700015;2530.6963164420386;2533.7972962163076;2534.797216222716;2383.976160238393;2413.4569721812627;2414.1550457339968;2417.9516409671883;2419.2863105383954;11041.447927603587;11155.832662510069;11201.775964480665;11223.551057957753;11232.943835280854;5831.446012628793;5964.701764911737;5984.311804142536;5998.610090344114;6011.248593925759;3315.187778994162;3410.897673069812;3425.160835595295;3547.166415892263;3563.2339047104997;1375.7317323121995;1405.6907480354305;1435.8205224346957;1468.5447511271434;1489.3521318226606;17410.7388389173;17454.91272543629;17508.037057961807;17521.386751463764;17533.298668053263;4758.881027974328;4854.466008739036;4924.236743304794;5077.644564880423;5147.845564633067;13981.370838312097;13996.300184990914;14020.369083391271;14023.228722420365;14052.086614370237;5976.551758618121;5977.9402205977385;5979.970100149471;5984.222051133324;5987.550933679991;4591.44902611682;5401.648892821954;5426.186072089139;5474.288342515448;5479.698616576126;3930.5283365996265;4256.404103425523;4273.1240095780295;4391.473023237232;4398.582134697199;1148.471703016605;1153.7176732196885;1166.0729719872722;1175.353555544447;1180.9468573914023;1065.1478816946567;1077.1813421799488;1077.7521170130915;1084.251866212311;1098.19282827122;7367.852642947219;7412.629368531552;7449.217832127549;7664.961675191588;7741.341985931146;1146.4611632532697;1153.6423708650345;1164.4759858063906;1168.112234701616;1182.7279725663145;4756.096341695067;4791.448983366958;4838.854834354975;4936.605071594336;5029.899402011939;13938.58184254474;14457.060291081256;14477.493287734878;14486;14491.420343186366;12312.26126432399;12721.618351449471;12998.155119917365;13010.959123270115;14395.568132956028;10673.679789606324;10839.783204335869;10864.565417383374;10868.782624347627;10910.672679819618;7245.637718114179;7545.471816972759;7553.64034473778;7565.810854728676;7687.461877668509;12749.235045896905;12811.359432028175;13082.215067096005;13101.672458188621;13131.343432828511;13329.466821327038;13335.266560338887;13346.332683365987;13353;13389.263590502616;8586.441881277697;9719.659811906833;10042.397456152654;10044.648437304659;10066.094051535398;10588.417637030037;10880.619178328721;10975.341479511255;10983.231173817756;10984.780304393707;9512.429254244767;9593.664221752206;9627.326087173831;9678.177354924628;9791.902080979098;9479.668211612561;9571.952140239255;9590.760230994281;9618.567164477756;9759.46322952216;8721.127887211229;8798.12018798115;8857.335699822668;8884.822303554021;8894.911050889408;6562.310957349409;6605.636689982097;6607.2071351438135;6647.833804154935;6724.260331363644;6377.23473183221;6428.710708018244;6447.6131432114225;6512.446442052478;6704.363085506869 04:03:30 INFO - PROCESS | 24319 | |4;prototype.html;405.6450605719995;431.4369747479539;431.99568004319946;435.27309393313163;445.9910801783964;5230.372355317362;5273.18265668821;5279.366476022878;5292.401167206298;5322.787088516455;4868.732219727914;5184.7148406837605;5188.766505507252;5215;5227.18978558324;4290.935635965448;4304.2137512932095;4321.1141715948315;4324.351347297899;4325.697201195918;4303.483581970152;4311.784410779464;4313.541281469564;4316.093620339732;4324.718893271943;4310.892227694301;4358.673099517533;4360.890977725567;4372.169287835317;4388.802503887333;4138.420621113047;4250.107477429743;4333.656566464375;4346.217680817484;4361.454818147731;4097.2996206574235;4105.44576482174;4114.485689288839;4141;4145.7719825409595;5141.177411614124;5180.585553155776;5183.429822719498;5192.428832828386;5240.9213861792105;4966.701997880139;5090.338256026693;5120.206368012964;5129.589632829365;5153.994970980661;5505.284313039279;5509.421510741355;5526.198701188305;5550.27846379968;5562.249096372019;4632.536746325374;4635.745034023127;4644.976775116136;4657.764273148874;4667.369905062841;5408.323959505062;5475.698836563987;5525.480492864454;5561.193626924073;5658.377578466366;4673.462551806518;4688.523115218695;4694.178518759203;4703.506131856174;4750.714957102516;4781.545753153445;4785.090832741768;4805.67843842946;4806.591439727592;4823.397075365579;4957.082939656175;4978.7120546077895;4993.275974983607;5049.671771334852;5077.923831142536;5341.946580534222;5408.107662235766;5414.675119492843;5422.322209723785;5432.91850622241;1615.4749706345485;1638.4019832761194;1640.8769342299374;1661.2939500712148;1674.831093733618;1275.457930379585;1286.395394164741;1308.3523655790445;1314.3691028306466;1316.8280230594778;5400.918986215132;5418.295621569249;5422.213779002102;5429.728513574306;5438.374586922476;5583.330000399978;5649;5668.121441176541;5671.6597004179885;5707.343655479673;5185.896282074337;5330.920940833078;5363.946360536344;5418.674879507243;5437.646552974044;2937.8090424122365;2943.484890144216;2943.67619561848;2947.8083924545267;2964.5986750731977;5588.441155884379;5759.473739459047;5769.423057694197;5776.5089967352405;5835.35811060783;5721.771129154788;5741.368449470555;5759.280089988752;5763.530299773531;5781.063343779881;5722.2561067061015;5736.275269247074;5792.333881603669;5814.476697097281;5820.476157145792;5249.501297376743;5524.779008839601;5541;5567.805126820542;5573.832785016456;5311.654742441729;5462.808801691922;5483.506484416422;5497.8075767347955;5529.253550770755;5614.691191984317;5675.659460432387;5750.223719797774;5762.654240745569;5801.477866991822;4656.8602941911795;4657.604103651092;4686.711154432558;4692.296155576691;4708.340832283415;5365.913859064544;5624.409437009055;5656.321241451053;5665.971670141623;5675.31896172462;5437.945620543902;5449.618526703092;5473.452654734495;5478.67127972307;5515.806946756844;5420.937170498656;5456.372517160577;5468.828079713836;5471.480209380103;5490.423505531861;5165.276861239355;5477.54914403923;5505.889882202254;5525.226468294522;5535.446455354432;5457.317835270591;5469.562435005269;5502.9174562382395;5525.419830917856;5557.610967232255;5163.483651634957;5385.542228910586;5394.892102158014;5402.594805389533;5452.809151679672 04:03:30 INFO - PROCESS | 24319 | |5;yui.html;854.7136709202417;884.1423818895673;904.3669431398021;912.1152482092368;939.1969865764769;17509.474715758533;18436.354727584538;18547.90726046371;18550.536236594093;18591.25634974601;14524.782128268058;17138.571535711613;17224.13879306036;17284;17292.654146917084;889.1286539191597;910.1171863292628;911.3392790227099;912.8356895758761;913.228322067855;924.0205382294789;925.3245131054334;926.6200857648365;927.1609193679697;927.8144371125768;968.5351031504882;973.352720440906;974.2741657465162;974.7319487141058;974.8342781727088;960.0639376607821;962.2927148545848;962.5187406296851;962.9374090684083;964.320154291223;702.3503259485007;702.4977141343963;705.7706245470191;706.1737766812842;706.6608028146467;17537.386191483238;17542.824571754245;17587.208575614128;17737.911310443495;17769.911150444295;17318.39385621497;17455.97725035541;17480.125993700392;18063.72904406435;18342.90828545862;13856.307184640727;13969.511067112704;14117.152970821784;14173.645658858508;14202.50291239812;4096.5903409658795;4181.916361672749;4195.832166713328;4199;4240;47322.526774732156;56310.43689563134;79170;82585.17414825835;83265;13679.794803077963;13990.230537320545;13992.16047037181;14031.298435078204;14172.64568385778;26029.73970260311;26212.344691382867;26334.47331053368;26483;26535.73464265371;8879.156480134377;8935.731928042169;8996.955015225012;9034.683786067457;9331.486768227676;5064.49355064498;5089.703782833957;5178.818741344035;5198.610104242121;5313.282706834528;3786.772793632336;3881.0879443330796;3904.7461914975434;3918.040080180374;3948.0524674078015;659.1003280522053;668.9130413046273;677.2381071294793;685.1640997982454;690.4062506244626;839.0686338164633;850.2432834777053;853.8377708235415;881.2333270055093;888.9199972002551;11289.266197697123;11423;11521.654350369503;11758.35329056893;11961.880381196077;781.6131015147424;798.660569258063;802.7270727952524;811.5860910935465;825.8513467575895;5641.633293835969;5694.430556944272;5751.3673495916255;5794.275715535558;5822.0975748758165;78823.60588197137;80481;80977;84416;86444.56777716072;57747;70222.29777702158;70603.0288119837;72086;72496;63179.36820631735;63531;65024;65239.673801630684;67469.66265168643;10905.454727263446;10906.945465272624;10917.23579349438;11161.218714689894;11266.436678166223;45644;45762;46281;46540.53459465497;46803.765981169876;52611;52992.73503632457;53087;53964.73017635044;55909;11981.460834262654;12093.213941093802;12357.567485137977;12399.566015189786;12612.495500180257;14354.210518421587;14508.637284067983;14589;14739.631509212355;14912.62718432048;14041.1575305482;14306.713865722835;15572.84427155714;15804.36782528686;15920.681586368439;14550.563483095524;14828.555143345286;15430.845691542941;16255.59361015984;16603.086830224453;14988.550343489713;15569.922150389175;15654.765178522104;16683.582910426852;16870.746938796172;11146.609868654557;11310.60412885545;12005.279683219034;12139.635810925687;12299.385030748248;11660.88339116598;12501.874981250072;12574.622761317176;13416.731665366833;14032.08791428554 04:03:30 INFO - PROCESS | 24319 | __end_tp_report 04:03:30 INFO - PROCESS | 24319 | __start_cc_report 04:03:30 INFO - PROCESS | 24319 | _x_x_mozilla_cycle_collect,1125 04:03:30 INFO - PROCESS | 24319 | __end_cc_report 04:03:30 INFO - PROCESS | 24319 | __startTimestamp1496055810233__endTimestamp 04:03:30 INFO - PROCESS | 24319 | 04:03:30 INFO - PROCESS | 24319 | ------- Summary: start ------- 04:03:30 INFO - PROCESS | 24319 | Number of tests: 6 04:03:30 INFO - PROCESS | 24319 | 04:03:30 INFO - PROCESS | 24319 | [#0] dojo.html Cycles:165 Average:5744.25 Median:5992.70 stddev:652.20 (10.9%) stddev-sans-first:628.74 04:03:30 INFO - PROCESS | 24319 | Values: 3444.0 3484.0 3493.4 3510.3 3537.6 5766.4 5838.7 5842.2 5874.1 5877.7 5830.2 5850.2 5875.2 5878.1 5878.8 5131.9 5178.7 5189.6 5238.7 5253.8 5009.2 5027.6 5254.4 5264.3 5266.2 5087.8 5139.5 5146.3 5152.8 5154.8 5089.1 5102.3 5107.3 5110.1 5115.2 5066.9 5125.1 5159.1 5160.1 5160.1 5731.5 5744.6 5821.5 5825.6 5847.4 6006.2 6053.8 6145.7 6145.8 6179.7 6264.2 6286.7 6287.3 6290.9 6316.4 5821.6 5863.5 5865.1 5867.4 5878.9 6057.2 6080.7 6276.1 6304.3 6396.2 6145.7 6165.5 6165.5 6167.7 6176.2 6255.1 6255.7 6259.4 6259.4 6262.3 5887.9 5947.6 6122.6 6168.3 6228.6 6161.5 6181.4 6195.2 6200.7 6209.3 4591.0 4620.0 4623.1 4737.9 4832.4 4248.6 4267.9 4281.4 4287.8 4319.7 5697.3 5818.3 5895.7 5971.5 6025.6 6167.0 6188.1 6194.9 6195.4 6210.3 5990.7 5995.9 5997.6 5998.4 6019.9 5149.3 5349.9 5357.7 5359.7 5362.4 6236.8 6304.9 6362.8 6372.3 6381.6 6299.6 6300.1 6307.8 6312.1 6313.4 6386.2 6402.6 6432.5 6444.8 6459.2 5860.1 5896.8 6024.0 6049.9 6170.4 6189.9 6207.4 6213.4 6214.2 6217.9 6042.4 6049.8 6051.8 6056.5 6096.5 5867.4 5903.9 5986.0 5992.7 6060.2 6049.4 6053.2 6067.8 6081.2 6108.0 6091.9 6101.8 6109.9 6116.8 6120.2 5749.9 5793.3 5874.2 5880.0 5933.1 04:03:30 INFO - PROCESS | 24319 | 04:03:30 INFO - PROCESS | 24319 | [#1] ext.html Cycles:180 Average:44733.35 Median:176421.26 stddev:72324.13 (41.0%) stddev-sans-first:72451.67 04:03:30 INFO - PROCESS | 24319 | Values: 766.1 807.4 826.7 906.1 914.6 31407.7 45135.0 45589.5 45881.5 45992.3 41660.0 41925.0 41932.4 46022.3 46145.3 9137.7 9278.5 9281.3 9285.0 9289.5 7715.8 7899.0 10660.8 10908.1 10917.5 10929.0 10950.3 10975.9 10977.3 10981.9 10832.0 10861.4 10875.5 10892.9 10905.1 10596.5 10641.8 10685.2 10688.2 10698.7 43889.1 44122.1 44123.6 44169.8 44190.3 4311.2 4338.4 4363.7 4463.3 4474.1 30661.7 31718.8 31900.5 32119.0 32671.0 4374.7 4408.5 4491.8 4541.3 4572.9 231069.0 231411.0 232115.0 232393.0 232577.0 54807.0 55100.4 55425.7 55574.2 55850.0 57701.7 58126.4 58255.7 58295.0 58345.1 16798.3 17056.3 17068.6 17109.8 17125.9 12185.4 14888.0 14984.7 15015.0 15024.9 12566.2 13750.4 13950.7 14070.4 14580.7 5288.2 5333.8 5346.2 5448.6 5467.8 1023.0 1028.0 1034.3 1038.4 1048.1 28671.6 29345.4 30133.0 30239.7 30493.8 1302.2 1306.5 1313.7 1314.9 1342.8 13799.4 13990.7 14074.7 14133.8 14377.6 320942.0 320964.0 321971.0 322397.0 322717.0 49551.0 49640.3 49642.0 49722.3 49762.3 1505.7 1510.2 1527.9 1529.3 1543.5 28523.4 29325.3 29711.9 29847.9 30288.7 37555.2 37839.4 37878.8 37920.2 37939.8 270842.0 271410.0 271730.0 271866.0 271876.0 30878.1 30947.0 31047.7 31531.0 31671.2 40825.4 41064.8 41553.8 41930.2 42397.6 32715.3 32880.7 33009.7 33059.5 33099.2 32137.8 32280.4 32880.5 33280.7 33579.7 36697.4 37046.0 37523.8 37759.4 37790.2 31163.5 31267.7 31320.7 31642.5 32442.2 24857.5 25341.9 25473.0 25549.6 26076.0 04:03:30 INFO - PROCESS | 24319 | 04:03:30 INFO - PROCESS | 24319 | [#2] jquery.html Cycles:180 Average:39428.63 Median:12427.45 stddev:116939.93 (941.0%) stddev-sans-first:117231.39 04:03:30 INFO - PROCESS | 24319 | Values: 471.5 474.7 487.5 488.4 492.5 20616.6 21512.2 21903.0 22072.0 22094.2 22183.6 22569.5 23047.0 23514.4 23730.0 6623.5 6667.0 6794.0 6805.6 6873.5 6780.6 6915.1 7336.4 7594.4 7619.0 7261.2 7751.9 7755.4 7771.5 7773.6 7581.1 7675.0 7680.0 7683.6 7691.8 7263.8 7373.3 7410.1 7456.0 7489.4 25278.6 25699.0 26099.5 26190.6 26621.2 3139.2 3184.9 3189.6 3197.3 3244.6 16144.3 16189.8 16248.7 16399.1 16587.8 2285.4 2322.3 2335.7 2377.2 2418.8 116187.0 120677.0 121164.4 121767.0 122630.4 17665.2 17801.0 18356.8 18513.2 18688.3 32209.2 32431.2 32442.4 32468.4 32710.0 10529.2 10551.2 10570.0 10718.9 10734.1 8893.0 8923.4 8937.5 9140.6 9155.0 8945.7 9302.8 9321.5 9400.9 9479.6 3523.8 3540.3 3732.6 3741.5 3877.3 966.7 979.7 983.2 985.4 1005.7 21476.7 21652.4 21772.0 21849.7 21897.8 1074.6 1093.2 1111.5 1116.3 1132.9 11274.2 11301.5 11641.1 11825.1 12356.6 671574.0 704131.0 716677.0 718195.0 745028.0 86207.1 97855.0 112783.4 114489.0 117556.0 1319.6 1364.0 1386.8 1392.2 1394.0 19358.0 19426.1 19581.3 19683.9 19762.7 52200.7 52740.2 53137.5 53391.0 53516.5 62088.4 67065.0 67532.7 68573.7 68801.7 12839.7 13358.2 13455.9 13463.5 13547.3 14684.9 14700.4 14874.4 15013.1 15017.2 12863.1 12897.0 12938.9 13081.5 13235.1 11767.0 12054.9 12233.5 12321.3 12363.9 13006.8 13112.8 13213.2 13225.9 13235.5 13238.6 13309.1 13434.8 13440.9 13532.2 12746.3 12833.8 12967.5 12970.2 13298.5 04:03:30 INFO - PROCESS | 24319 | 04:03:30 INFO - PROCESS | 24319 | [#3] mootools.html Cycles:180 Average:7237.68 Median:2437.97 stddev:4544.47 (186.4%) stddev-sans-first:4536.36 04:03:30 INFO - PROCESS | 24319 | Values: 1442.2 1603.7 1612.1 1625.3 1628.6 9643.4 11191.6 11434.7 11907.2 11930.7 11687.1 11727.2 11738.9 11743.6 11746.3 2548.5 2591.3 2592.8 2594.1 2597.4 2071.1 2136.2 2502.0 2565.3 2573.3 2419.9 2430.4 2445.5 2447.7 2450.8 2525.2 2529.1 2530.7 2533.8 2534.8 2384.0 2413.5 2414.2 2418.0 2419.3 11041.4 11155.8 11201.8 11223.6 11232.9 5831.4 5964.7 5984.3 5998.6 6011.2 3315.2 3410.9 3425.2 3547.2 3563.2 1375.7 1405.7 1435.8 1468.5 1489.4 17410.7 17454.9 17508.0 17521.4 17533.3 4758.9 4854.5 4924.2 5077.6 5147.8 13981.4 13996.3 14020.4 14023.2 14052.1 5976.6 5977.9 5980.0 5984.2 5987.6 4591.4 5401.6 5426.2 5474.3 5479.7 3930.5 4256.4 4273.1 4391.5 4398.6 1148.5 1153.7 1166.1 1175.4 1180.9 1065.1 1077.2 1077.8 1084.3 1098.2 7367.9 7412.6 7449.2 7665.0 7741.3 1146.5 1153.6 1164.5 1168.1 1182.7 4756.1 4791.4 4838.9 4936.6 5029.9 13938.6 14457.1 14477.5 14486.0 14491.4 12312.3 12721.6 12998.2 13011.0 14395.6 10673.7 10839.8 10864.6 10868.8 10910.7 7245.6 7545.5 7553.6 7565.8 7687.5 12749.2 12811.4 13082.2 13101.7 13131.3 13329.5 13335.3 13346.3 13353.0 13389.3 8586.4 9719.7 10042.4 10044.6 10066.1 10588.4 10880.6 10975.3 10983.2 10984.8 9512.4 9593.7 9627.3 9678.2 9791.9 9479.7 9572.0 9590.8 9618.6 9759.5 8721.1 8798.1 8857.3 8884.8 8894.9 6562.3 6605.6 6607.2 6647.8 6724.3 6377.2 6428.7 6447.6 6512.4 6704.4 04:03:30 INFO - PROCESS | 24319 | 04:03:30 INFO - PROCESS | 24319 | [#4] prototype.html Cycles:180 Average:4775.57 Median:5276.27 stddev:1261.88 (23.9%) stddev-sans-first:1222.05 04:03:30 INFO - PROCESS | 24319 | Values: 405.6 431.4 432.0 435.3 446.0 5230.4 5273.2 5279.4 5292.4 5322.8 4868.7 5184.7 5188.8 5215.0 5227.2 4290.9 4304.2 4321.1 4324.4 4325.7 4303.5 4311.8 4313.5 4316.1 4324.7 4310.9 4358.7 4360.9 4372.2 4388.8 4138.4 4250.1 4333.7 4346.2 4361.5 4097.3 4105.4 4114.5 4141.0 4145.8 5141.2 5180.6 5183.4 5192.4 5240.9 4966.7 5090.3 5120.2 5129.6 5154.0 5505.3 5509.4 5526.2 5550.3 5562.2 4632.5 4635.7 4645.0 4657.8 4667.4 5408.3 5475.7 5525.5 5561.2 5658.4 4673.5 4688.5 4694.2 4703.5 4750.7 4781.5 4785.1 4805.7 4806.6 4823.4 4957.1 4978.7 4993.3 5049.7 5077.9 5341.9 5408.1 5414.7 5422.3 5432.9 1615.5 1638.4 1640.9 1661.3 1674.8 1275.5 1286.4 1308.4 1314.4 1316.8 5400.9 5418.3 5422.2 5429.7 5438.4 5583.3 5649.0 5668.1 5671.7 5707.3 5185.9 5330.9 5363.9 5418.7 5437.6 2937.8 2943.5 2943.7 2947.8 2964.6 5588.4 5759.5 5769.4 5776.5 5835.4 5721.8 5741.4 5759.3 5763.5 5781.1 5722.3 5736.3 5792.3 5814.5 5820.5 5249.5 5524.8 5541.0 5567.8 5573.8 5311.7 5462.8 5483.5 5497.8 5529.3 5614.7 5675.7 5750.2 5762.7 5801.5 4656.9 4657.6 4686.7 4692.3 4708.3 5365.9 5624.4 5656.3 5666.0 5675.3 5437.9 5449.6 5473.5 5478.7 5515.8 5420.9 5456.4 5468.8 5471.5 5490.4 5165.3 5477.5 5505.9 5525.2 5535.4 5457.3 5469.6 5502.9 5525.4 5557.6 5163.5 5385.5 5394.9 5402.6 5452.8 04:03:30 INFO - PROCESS | 24319 | 04:03:30 INFO - PROCESS | 24319 | [#5] yui.html Cycles:180 Average:18517.73 Median:45703.00 stddev:22201.42 (48.6%) stddev-sans-first:22224.08 04:03:30 INFO - PROCESS | 24319 | Values: 854.7 884.1 904.4 912.1 939.2 17509.5 18436.4 18547.9 18550.5 18591.3 14524.8 17138.6 17224.1 17284.0 17292.7 889.1 910.1 911.3 912.8 913.2 924.0 925.3 926.6 927.2 927.8 968.5 973.4 974.3 974.7 974.8 960.1 962.3 962.5 962.9 964.3 702.4 702.5 705.8 706.2 706.7 17537.4 17542.8 17587.2 17737.9 17769.9 17318.4 17456.0 17480.1 18063.7 18342.9 13856.3 13969.5 14117.2 14173.6 14202.5 4096.6 4181.9 4195.8 4199.0 4240.0 47322.5 56310.4 79170.0 82585.2 83265.0 13679.8 13990.2 13992.2 14031.3 14172.6 26029.7 26212.3 26334.5 26483.0 26535.7 8879.2 8935.7 8997.0 9034.7 9331.5 5064.5 5089.7 5178.8 5198.6 5313.3 3786.8 3881.1 3904.7 3918.0 3948.1 659.1 668.9 677.2 685.2 690.4 839.1 850.2 853.8 881.2 888.9 11289.3 11423.0 11521.7 11758.4 11961.9 781.6 798.7 802.7 811.6 825.9 5641.6 5694.4 5751.4 5794.3 5822.1 78823.6 80481.0 80977.0 84416.0 86444.6 57747.0 70222.3 70603.0 72086.0 72496.0 63179.4 63531.0 65024.0 65239.7 67469.7 10905.5 10906.9 10917.2 11161.2 11266.4 45644.0 45762.0 46281.0 46540.5 46803.8 52611.0 52992.7 53087.0 53964.7 55909.0 11981.5 12093.2 12357.6 12399.6 12612.5 14354.2 14508.6 14589.0 14739.6 14912.6 14041.2 14306.7 15572.8 15804.4 15920.7 14550.6 14828.6 15430.8 16255.6 16603.1 14988.6 15569.9 15654.8 16683.6 16870.7 11146.6 11310.6 12005.3 12139.6 12299.4 11660.9 12501.9 12574.6 13416.7 14032.1 04:03:30 INFO - PROCESS | 24319 | -------- Summary: end -------- 04:03:30 INFO - PROCESS | 24319 | 04:03:30 INFO - TEST-INFO | 24319: exit 0 04:03:31 INFO - TEST-OK | dromaeo_css | took 1116030ms 04:03:31 INFO - TEST-START | kraken 04:03:31 INFO - operating with platform_type : linux_ 04:03:31 INFO - Initialising browser for kraken test... 04:03:31 INFO - TEST-INFO | started process 24623 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp569Mwn/profile http://localhost:54007/getInfo.html) 04:03:35 INFO - PROCESS | 24623 | __metrics Screen width/height:1600/1200 04:03:35 INFO - PROCESS | 24623 | colorDepth:24 04:03:35 INFO - PROCESS | 24623 | Browser inner width/height: 1024/697 04:03:35 INFO - PROCESS | 24623 | __metrics 04:03:36 INFO - PROCESS | 24623 | 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" 04:03:36 INFO - PROCESS | 24623 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:03:36 INFO - PROCESS | 24623 | console.error: PushService: 04:03:36 INFO - PROCESS | 24623 | stateChangeProcessEnqueue: Error transitioning state 04:03:36 INFO - PROCESS | 24623 | UnknownError 04:03:37 INFO - TEST-INFO | 24623: exit 0 04:03:37 INFO - Browser initialized. 04:03:37 INFO - Running cycle 1/1 for kraken test... 04:03:37 INFO - TEST-INFO | started process 24713 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp569Mwn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:03:48 INFO - PROCESS | 24713 | RSS: Main: 141889536 04:03:48 INFO - PROCESS | 24713 | 04:03:51 INFO - PROCESS | 24713 | Cycle 1(1): loaded http://localhost:54007/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54007/tests/kraken/driver.html?testName=audio-beat-detection) 04:03:52 INFO - PROCESS | 24713 | RSS: Main: 183898112 04:03:52 INFO - PROCESS | 24713 | 04:03:54 INFO - PROCESS | 24713 | Cycle 1(1): loaded http://localhost:54007/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54007/tests/kraken/driver.html?testName=audio-dft) 04:03:55 INFO - PROCESS | 24713 | RSS: Main: 173113344 04:03:55 INFO - PROCESS | 24713 | 04:03:58 INFO - PROCESS | 24713 | Cycle 1(1): loaded http://localhost:54007/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54007/tests/kraken/driver.html?testName=audio-fft) 04:03:58 INFO - PROCESS | 24713 | RSS: Main: 265162752 04:03:58 INFO - PROCESS | 24713 | 04:04:00 INFO - PROCESS | 24713 | Cycle 1(1): loaded http://localhost:54007/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54007/tests/kraken/driver.html?testName=audio-oscillator) 04:04:01 INFO - PROCESS | 24713 | RSS: Main: 171204608 04:04:01 INFO - PROCESS | 24713 | 04:04:03 INFO - PROCESS | 24713 | Cycle 1(1): loaded http://localhost:54007/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54007/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:04:03 INFO - PROCESS | 24713 | RSS: Main: 174059520 04:04:03 INFO - PROCESS | 24713 | 04:04:06 INFO - PROCESS | 24713 | Cycle 1(1): loaded http://localhost:54007/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54007/tests/kraken/driver.html?testName=imaging-darkroom) 04:04:07 INFO - PROCESS | 24713 | RSS: Main: 208822272 04:04:07 INFO - PROCESS | 24713 | 04:04:10 INFO - PROCESS | 24713 | Cycle 1(1): loaded http://localhost:54007/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54007/tests/kraken/driver.html?testName=imaging-desaturate) 04:04:11 INFO - PROCESS | 24713 | RSS: Main: 211410944 04:04:11 INFO - PROCESS | 24713 | 04:04:14 INFO - PROCESS | 24713 | Cycle 1(1): loaded http://localhost:54007/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54007/tests/kraken/driver.html?testName=json-parse-financial) 04:04:14 INFO - PROCESS | 24713 | RSS: Main: 211402752 04:04:14 INFO - PROCESS | 24713 | 04:04:16 INFO - PROCESS | 24713 | Cycle 1(1): loaded http://localhost:54007/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54007/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:04:17 INFO - PROCESS | 24713 | RSS: Main: 173748224 04:04:17 INFO - PROCESS | 24713 | 04:04:18 INFO - PROCESS | 24713 | Cycle 1(1): loaded http://localhost:54007/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54007/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:04:19 INFO - PROCESS | 24713 | RSS: Main: 179982336 04:04:19 INFO - PROCESS | 24713 | 04:04:21 INFO - PROCESS | 24713 | Cycle 1(1): loaded http://localhost:54007/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54007/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:04:22 INFO - PROCESS | 24713 | RSS: Main: 185384960 04:04:22 INFO - PROCESS | 24713 | 04:04:24 INFO - PROCESS | 24713 | Cycle 1(1): loaded http://localhost:54007/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54007/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:04:25 INFO - PROCESS | 24713 | RSS: Main: 181567488 04:04:25 INFO - PROCESS | 24713 | 04:04:27 INFO - PROCESS | 24713 | Cycle 1(1): loaded http://localhost:54007/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54007/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:04:28 INFO - PROCESS | 24713 | RSS: Main: 184987648 04:04:28 INFO - PROCESS | 24713 | 04:04:30 INFO - PROCESS | 24713 | Cycle 1(1): loaded http://localhost:54007/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54007/tests/kraken/driver.html?testName=ai-astar) 04:04:30 INFO - PROCESS | 24713 | RSS: Main: 238612480 04:04:30 INFO - PROCESS | 24713 | 04:04:30 INFO - PROCESS | 24713 | __start_tp_report 04:04:30 INFO - PROCESS | 24713 | _x_x_mozilla_page_load 04:04:30 INFO - PROCESS | 24713 | _x_x_mozilla_page_load_details 04:04:30 INFO - PROCESS | 24713 | |i|pagename|runs| 04:04:30 INFO - PROCESS | 24713 | |0;ai-astar;102;112;113;113;112;116;112;111;113;113 04:04:30 INFO - PROCESS | 24713 | |1;audio-beat-detection;149;119;118;152;116;121;120;115;136;114 04:04:30 INFO - PROCESS | 24713 | |2;audio-dft;161;160;160;161;161;160;160;161;160;159 04:04:30 INFO - PROCESS | 24713 | |3;audio-fft;75;75;74;109;76;76;77;76;96;75 04:04:30 INFO - PROCESS | 24713 | |4;audio-oscillator;83;82;110;82;82;82;95;82;82;94 04:04:30 INFO - PROCESS | 24713 | |5;imaging-gaussian-blur;113;113;113;113;113;113;112;113;113;113 04:04:30 INFO - PROCESS | 24713 | |6;imaging-darkroom;147;147;146;147;146;146;146;147;145;146 04:04:30 INFO - PROCESS | 24713 | |7;imaging-desaturate;93;94;93;94;94;93;94;93;94;93 04:04:30 INFO - PROCESS | 24713 | |8;json-parse-financial;54;54;54;54;53;54;53;55;53;61 04:04:30 INFO - PROCESS | 24713 | |9;json-stringify-tinderbox;53;53;54;53;52;52;53;53;54;52 04:04:30 INFO - PROCESS | 24713 | |10;stanford-crypto-aes;85;76;79;79;85;79;79;82;79;108 04:04:30 INFO - PROCESS | 24713 | |11;stanford-crypto-ccm;120;119;121;118;117;119;129;130;143;119 04:04:30 INFO - PROCESS | 24713 | |12;stanford-crypto-pbkdf2;163;160;161;155;164;162;157;171;166;155 04:04:30 INFO - PROCESS | 24713 | |13;stanford-crypto-sha256-iterative;62;59;60;68;60;65;59;58;58;60 04:04:30 INFO - PROCESS | 24713 | __end_tp_report 04:04:30 INFO - PROCESS | 24713 | __start_cc_report 04:04:30 INFO - PROCESS | 24713 | _x_x_mozilla_cycle_collect,1631 04:04:30 INFO - PROCESS | 24713 | __end_cc_report 04:04:30 INFO - PROCESS | 24713 | __startTimestamp1496055870337__endTimestamp 04:04:30 INFO - PROCESS | 24713 | 04:04:30 INFO - PROCESS | 24713 | ------- Summary: start ------- 04:04:30 INFO - PROCESS | 24713 | Number of tests: 14 04:04:30 INFO - PROCESS | 24713 | 04:04:30 INFO - PROCESS | 24713 | [#0] ai-astar Cycles:10 Average:111.70 Median:113.00 stddev:3.65 (3.2%) stddev-sans-first:1.39 04:04:30 INFO - PROCESS | 24713 | Values: 102.0 112.0 113.0 113.0 112.0 116.0 112.0 111.0 113.0 113.0 04:04:30 INFO - PROCESS | 24713 | 04:04:30 INFO - PROCESS | 24713 | [#1] audio-beat-detection Cycles:10 Average:126.00 Median:120.50 stddev:14.31 (11.9%) stddev-sans-first:12.53 04:04:30 INFO - PROCESS | 24713 | Values: 149.0 119.0 118.0 152.0 116.0 121.0 120.0 115.0 136.0 114.0 04:04:30 INFO - PROCESS | 24713 | 04:04:30 INFO - PROCESS | 24713 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.50 stddev:0.67 (0.4%) stddev-sans-first:0.67 04:04:30 INFO - PROCESS | 24713 | Values: 161.0 160.0 160.0 161.0 161.0 160.0 160.0 161.0 160.0 159.0 04:04:30 INFO - PROCESS | 24713 | 04:04:30 INFO - PROCESS | 24713 | [#3] audio-fft Cycles:10 Average:80.90 Median:76.00 stddev:11.82 (15.5%) stddev-sans-first:12.34 04:04:30 INFO - PROCESS | 24713 | Values: 75.0 75.0 74.0 109.0 76.0 76.0 77.0 76.0 96.0 75.0 04:04:30 INFO - PROCESS | 24713 | 04:04:30 INFO - PROCESS | 24713 | [#4] audio-oscillator Cycles:10 Average:87.40 Median:82.00 stddev:9.47 (11.5%) stddev-sans-first:9.91 04:04:30 INFO - PROCESS | 24713 | Values: 83.0 82.0 110.0 82.0 82.0 82.0 95.0 82.0 82.0 94.0 04:04:30 INFO - PROCESS | 24713 | 04:04:30 INFO - PROCESS | 24713 | [#5] imaging-gaussian-blur Cycles:10 Average:112.90 Median:113.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:04:30 INFO - PROCESS | 24713 | Values: 113.0 113.0 113.0 113.0 113.0 113.0 112.0 113.0 113.0 113.0 04:04:30 INFO - PROCESS | 24713 | 04:04:30 INFO - PROCESS | 24713 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.67 (0.5%) stddev-sans-first:0.67 04:04:30 INFO - PROCESS | 24713 | Values: 147.0 147.0 146.0 147.0 146.0 146.0 146.0 147.0 145.0 146.0 04:04:30 INFO - PROCESS | 24713 | 04:04:30 INFO - PROCESS | 24713 | [#7] imaging-desaturate Cycles:10 Average:93.50 Median:94.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 04:04:30 INFO - PROCESS | 24713 | Values: 93.0 94.0 93.0 94.0 94.0 93.0 94.0 93.0 94.0 93.0 04:04:30 INFO - PROCESS | 24713 | 04:04:30 INFO - PROCESS | 24713 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:54.00 stddev:2.37 (4.4%) stddev-sans-first:2.51 04:04:30 INFO - PROCESS | 24713 | Values: 54.0 54.0 54.0 54.0 53.0 54.0 53.0 55.0 53.0 61.0 04:04:30 INFO - PROCESS | 24713 | 04:04:30 INFO - PROCESS | 24713 | [#9] json-stringify-tinderbox Cycles:10 Average:52.90 Median:53.00 stddev:0.74 (1.4%) stddev-sans-first:0.78 04:04:30 INFO - PROCESS | 24713 | Values: 53.0 53.0 54.0 53.0 52.0 52.0 53.0 53.0 54.0 52.0 04:04:30 INFO - PROCESS | 24713 | 04:04:30 INFO - PROCESS | 24713 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:79.00 stddev:9.21 (11.7%) stddev-sans-first:9.74 04:04:30 INFO - PROCESS | 24713 | Values: 85.0 76.0 79.0 79.0 85.0 79.0 79.0 82.0 79.0 108.0 04:04:30 INFO - PROCESS | 24713 | 04:04:30 INFO - PROCESS | 24713 | [#11] stanford-crypto-ccm Cycles:10 Average:123.50 Median:120.50 stddev:8.20 (6.8%) stddev-sans-first:8.59 04:04:30 INFO - PROCESS | 24713 | Values: 120.0 119.0 121.0 118.0 117.0 119.0 129.0 130.0 143.0 119.0 04:04:30 INFO - PROCESS | 24713 | 04:04:30 INFO - PROCESS | 24713 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.40 Median:162.50 stddev:5.02 (3.1%) stddev-sans-first:5.29 04:04:30 INFO - PROCESS | 24713 | Values: 163.0 160.0 161.0 155.0 164.0 162.0 157.0 171.0 166.0 155.0 04:04:30 INFO - PROCESS | 24713 | 04:04:30 INFO - PROCESS | 24713 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.90 Median:60.00 stddev:3.25 (5.4%) stddev-sans-first:3.42 04:04:30 INFO - PROCESS | 24713 | Values: 62.0 59.0 60.0 68.0 60.0 65.0 59.0 58.0 58.0 60.0 04:04:30 INFO - PROCESS | 24713 | -------- Summary: end -------- 04:04:30 INFO - PROCESS | 24713 | 04:04:31 INFO - TEST-INFO | 24713: exit 0 04:04:31 INFO - TEST-OK | kraken | took 60334ms 04:04:31 INFO - SUITE-END | took 1176s 04:04:31 INFO - Completed test suite (00:19:36) 04:04:31 INFO - javascript benchmark 04:04:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7959.389618083896, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3444.0356700123966, 3484.0, 3493.4410494320914, 3510.2979404119183, 3537.6285490023547, 5766.394528574497, 5838.737256823442, 5842.240508733858, 5874.089516124996, 5877.67672777997, 5830.183774271605, 5850.151727999448, 5875.206847075643, 5878.1476685880525, 5878.823635290937, 5131.897362052766, 5178.715170665612, 5189.610779191576, 5238.685678859261, 5253.789848406078, 5009.198528235483, 5027.622928280375, 5254.395744489375, 5264.341957255343, 5266.236395722618, 5087.79648814047, 5139.511746384088, 5146.279520867063, 5152.819651312205, 5154.819581314655, 5089.058524173021, 5102.260172275, 5107.310513080743, 5110.080185566597, 5115.18157094863, 5066.873328166788, 5125.077486052509, 5159.071367153911, 5160.0969830279555, 5160.14857548504, 5731.484166425042, 5744.569157313218, 5821.53427725781, 5825.563082768809, 5847.44449277318, 6006.249218847644, 6053.848653783647, 6145.661988590626, 6145.801568694106, 6179.66011869347, 6264.185655864754, 6286.717097730613, 6287.308396076428, 6290.87418251637, 6316.368363163693, 5821.592488525847, 5863.5309175265875, 5865.090910908816, 5867.413258674099, 5878.911816322759, 6057.242844644419, 6080.726367313481, 6276.121343011982, 6304.306526282106, 6396.232452105684, 6145.66198859067, 6165.5375846810775, 6165.537584681167, 6167.691615419211, 6176.227971503562, 6255.093011513305, 6255.6872156392, 6259.405356491126, 6259.405356491126, 6262.3111457739615, 5887.911681324784, 5947.5539334550085, 6122.632642041492, 6168.321484636686, 6228.626282423069, 6161.537884658668, 6181.443670069715, 6195.19462469876, 6200.720967556471, 6209.348018458088, 4590.9540904591195, 4620.0, 4623.052274283764, 4737.881552961135, 4832.395950506187, 4248.553901840324, 4267.871963841089, 4281.443412356436, 4287.764172970454, 4319.719218250803, 5697.3448053474385, 5818.33089194748, 5895.734691938873, 5971.5222782177325, 6025.638461692312, 6167.013277875608, 6188.071789231652, 6194.938050619527, 6195.442410183015, 6210.254769427697, 5990.670513121733, 5995.910061349084, 5997.6401415914315, 5998.430149135826, 6019.879602407927, 5149.304843846107, 5349.893002140013, 5357.732113394392, 5359.678419294854, 5362.436944120889, 6236.844078898064, 6304.936950630527, 6362.840928976812, 6372.330905254881, 6381.585196962183, 6299.559030867978, 6300.149479820166, 6307.779227727007, 6312.084747711648, 6313.43179113882, 6386.16979792624, 6402.583832051088, 6432.453241474527, 6444.8388790280615, 6459.192600924885, 5860.120981852756, 5896.764129434946, 6023.969880150571, 6049.879002420015, 6170.444659980623, 6189.876202475835, 6207.441330280297, 6213.440790328892, 6214.161088253028, 6217.875642487215, 6042.425969532887, 6049.76710588594, 6051.818445446644, 6056.515478761777, 6096.542759293159, 5867.413258674269, 5903.881922361615, 5985.970070149621, 5992.700364981821, 6060.181875446759, 6049.425304596057, 6053.243344581927, 6067.817965461043, 6081.209442772411, 6108.0, 6091.939080609137, 6101.816945491642, 6109.908351374644, 6116.785912493041, 6120.204373431426, 5749.913751293818, 5793.275840519935, 5874.177615133799, 5880.029795083934, 5933.080372542263], "value": 5701.424134319661, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [766.1380946435261, 807.4105902691036, 826.7065191856891, 906.1074841281337, 914.6021480655911, 31407.68592314076, 45135.0, 45589.54410455898, 45881.541184588226, 45992.31011534829, 41660.0, 41925.0, 41932.371014434735, 46022.309665355046, 46145.307820382724, 9137.680181193642, 9278.489683067428, 9281.303902207328, 9284.953575232148, 9289.489078100736, 7715.768526944201, 7899.0, 10660.840087398696, 10908.072813810835, 10917.454127293644, 10929.0, 10950.288231264982, 10975.890241097566, 10977.341359518414, 10981.945090274538, 10831.970962758565, 10861.40262285574, 10875.45622718861, 10892.891071089267, 10905.127589792797, 10596.470176491144, 10641.840372394421, 10685.198610104273, 10688.198385121146, 10698.679039628823, 43889.12221755579, 44122.117557648664, 44123.558764412264, 44169.77915110436, 44190.33714494285, 4311.245532031913, 4338.436003319548, 4363.716358436724, 4463.308187230984, 4474.127545128701, 30661.693383066107, 31718.841405793053, 31900.521492177635, 32119.0, 32671.0, 4374.671899607511, 4408.493023302329, 4491.8203271869415, 4541.34150548172, 4572.9314060289125, 231069.0, 231411.0, 232115.0, 232393.0, 232577.0, 54807.0, 55100.448995509534, 55425.722871385384, 55574.16638750422, 55850.0, 57701.71149144227, 58126.41873581295, 58255.70872145697, 58295.0, 58345.124823127684, 16798.328066877188, 17056.31774728997, 17068.573285667957, 17109.828901711073, 17125.91437042807, 12185.390730463441, 14888.0, 14984.70030599382, 15015.0, 15024.924875375553, 12566.183198092094, 13750.449982000608, 13950.651233719036, 14070.437182512585, 14580.708385832437, 5288.206768984606, 5333.759980800795, 5346.224797404355, 5448.645838020516, 5467.835964921059, 1022.9539670714836, 1027.9588816447258, 1034.332855308322, 1038.4236748604446, 1048.145761204631, 28671.56992645112, 29345.413091738046, 30133.0, 30239.697603023687, 30493.847530762203, 1302.218668798732, 1306.5296493262417, 1313.6940700206862, 1314.8750868667462, 1342.8052932324758, 13799.396644144626, 13990.650233744034, 14074.71850562983, 14133.78799318011, 14377.56867293983, 320942.0, 320964.0, 321971.0, 322397.0, 322717.0, 49551.0, 49640.25539616909, 49642.0, 49722.25416618754, 49762.25356619654, 1505.6913332766756, 1510.2222355486933, 1527.9236038198046, 1529.3041666041925, 1543.5137931551526, 28523.42953140967, 29325.26686832761, 29711.85144074266, 29847.850760746056, 30288.69711302859, 37555.248895022494, 37839.43240851334, 37878.8106059468, 37920.241595168496, 37939.81030094832, 270842.0, 271410.0, 271730.0, 271866.0, 271876.0, 30878.0736577903, 30947.0, 31047.68952310448, 31531.0, 31671.20821979469, 40825.387619185145, 41064.79467602643, 41553.79223103865, 41930.161396772506, 42397.576024239366, 32715.34569308648, 32880.67119328776, 33009.66990330066, 33059.504107437926, 33099.17252068718, 32137.839310803298, 32280.35439291248, 32880.50679239861, 33280.667193327754, 33579.66420335766, 36697.44953825641, 37046.0, 37523.81238093792, 37759.433608496445, 37790.244195116495, 31163.53254701136, 31267.687323126476, 31320.686793131776, 31642.525362120046, 32442.188945276557, 24857.502849943263, 25341.87329063343, 25473.03275861189, 25549.61675574905, 26076.0], "value": 19048.600967264345, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [471.48372532077406, 474.7412660100245, 487.4759633394102, 488.379757707711, 492.50257240187403, 20616.587668246644, 21512.247071352507, 21903.0, 22072.0, 22094.226702065433, 22183.556328873412, 22569.54860902781, 23047.0, 23514.412139696473, 23730.0, 6623.5032372572, 6666.966665166668, 6794.0, 6805.557638753465, 6873.450123990069, 6780.627065511395, 6915.135608048994, 7336.449766267525, 7594.354479869217, 7618.961905190494, 7261.237570055147, 7751.922480775176, 7755.418343624223, 7771.533707977539, 7773.611319434034, 7581.090269167707, 7674.961625191839, 7679.961600191991, 7683.577403242847, 7691.807704807425, 7263.782086537412, 7373.29953654402, 7410.147832999221, 7455.962720186419, 7489.438292128058, 25278.620820687705, 25699.0, 26099.478010439874, 26190.607140892902, 26621.201363959113, 3139.199504126433, 3184.9203769905707, 3189.6331921829055, 3197.328561002192, 3244.6106467224085, 16144.273507692182, 16189.83810161895, 16248.675026499523, 16399.098049607266, 16587.751183732253, 2285.3600991722346, 2322.3149170994598, 2335.708036495438, 2377.1798729438315, 2418.830681852271, 116187.0, 120677.0, 121164.39417802854, 121767.0, 122630.38684806519, 17665.233476652487, 17801.0, 18356.816431835778, 18513.166907489194, 18688.34590789316, 32209.194770130933, 32431.189220269684, 32442.351152976807, 32468.350632987207, 32710.0, 10529.157667386591, 10551.15590752738, 10570.0, 10718.946405267923, 10734.087602553715, 8892.955535222283, 8923.375363724477, 8937.508437036025, 9140.63437462494, 9155.0, 8945.73162805117, 9302.813943721088, 9321.533923303808, 9400.905990940004, 9479.573419196153, 3523.7709548879243, 3540.345036168317, 3732.6267373263, 3741.540669570324, 3877.263319969197, 966.709987003896, 979.6913972098766, 983.2232536296389, 985.4038306824411, 1005.7133716890651, 21476.677849832264, 21652.35042948714, 21772.0, 21849.67225491619, 21897.781022189574, 1074.6292529077455, 1093.223811094132, 1111.5331560744507, 1116.3413585984308, 1132.932024078558, 11274.154438416988, 11301.547938082385, 11641.126915481373, 11825.113116516295, 12356.567520136752, 671574.0, 704131.0, 716677.0, 718195.0, 745028.0, 86207.13792861991, 97855.0, 112783.43608281905, 114489.0, 117556.0, 1319.6041187643668, 1363.9659008524866, 1386.7573174694387, 1392.2273138408282, 1393.958181254564, 19358.032098395306, 19426.125824337658, 19581.314653987043, 19683.901580492005, 19762.70355944691, 52200.738996304775, 52740.20889686734, 53137.46862531325, 53391.0, 53516.46483535115, 62088.37911621007, 67065.0, 67532.66233668997, 68573.65713171402, 68801.65599171972, 12839.743205136032, 13358.198508089547, 13455.932720336335, 13463.528776492776, 13547.322633868464, 14684.926575367055, 14700.41198352054, 14874.405023798927, 15013.099214047192, 15017.249137543298, 12863.099583029098, 12897.0, 12938.935305323414, 13081.476740930257, 13235.139715918434, 11767.0, 12054.939725301318, 12233.510659573873, 12321.260724356567, 12363.93818030904, 13006.80489792635, 13112.803307950198, 13213.207207567577, 13225.867741322463, 13235.536756213487, 13238.602841914759, 13309.134906231064, 13434.798478023033, 13440.93279533596, 13532.188068715908, 12746.298953557643, 12833.807492887427, 12967.481300748243, 12970.22178669283, 13298.468061277441], "value": 11907.372687017418, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1442.156338541953, 1603.7113319602468, 1612.1455628516887, 1625.3336132185807, 1628.6254161542845, 9643.421394716323, 11191.608293709722, 11434.7141321467, 11907.16649834512, 11930.701732456693, 11687.123465740062, 11727.237729547594, 11738.882611173885, 11743.588974385899, 11746.295222286668, 2548.541262572741, 2591.300348905794, 2592.844429334246, 2594.0531705927297, 2597.4025974025985, 2071.099071903719, 2136.2202795979433, 2501.962470562943, 2565.307367010906, 2573.3180707112538, 2419.9274021779374, 2430.3924018995253, 2445.5475736988715, 2447.706275246973, 2450.767177118171, 2525.229804909502, 2529.0895277700015, 2530.6963164420386, 2533.7972962163076, 2534.797216222716, 2383.976160238393, 2413.4569721812627, 2414.1550457339968, 2417.9516409671883, 2419.2863105383954, 11041.447927603587, 11155.832662510069, 11201.775964480665, 11223.551057957753, 11232.943835280854, 5831.446012628793, 5964.701764911737, 5984.311804142536, 5998.610090344114, 6011.248593925759, 3315.187778994162, 3410.897673069812, 3425.160835595295, 3547.166415892263, 3563.2339047104997, 1375.7317323121995, 1405.6907480354305, 1435.8205224346957, 1468.5447511271434, 1489.3521318226606, 17410.7388389173, 17454.91272543629, 17508.037057961807, 17521.386751463764, 17533.298668053263, 4758.881027974328, 4854.466008739036, 4924.236743304794, 5077.644564880423, 5147.845564633067, 13981.370838312097, 13996.300184990914, 14020.369083391271, 14023.228722420365, 14052.086614370237, 5976.551758618121, 5977.9402205977385, 5979.970100149471, 5984.222051133324, 5987.550933679991, 4591.44902611682, 5401.648892821954, 5426.186072089139, 5474.288342515448, 5479.698616576126, 3930.5283365996265, 4256.404103425523, 4273.1240095780295, 4391.473023237232, 4398.582134697199, 1148.471703016605, 1153.7176732196885, 1166.0729719872722, 1175.353555544447, 1180.9468573914023, 1065.1478816946567, 1077.1813421799488, 1077.7521170130915, 1084.251866212311, 1098.19282827122, 7367.852642947219, 7412.629368531552, 7449.217832127549, 7664.961675191588, 7741.341985931146, 1146.4611632532697, 1153.6423708650345, 1164.4759858063906, 1168.112234701616, 1182.7279725663145, 4756.096341695067, 4791.448983366958, 4838.854834354975, 4936.605071594336, 5029.899402011939, 13938.58184254474, 14457.060291081256, 14477.493287734878, 14486.0, 14491.420343186366, 12312.26126432399, 12721.618351449471, 12998.155119917365, 13010.959123270115, 14395.568132956028, 10673.679789606324, 10839.783204335869, 10864.565417383374, 10868.782624347627, 10910.672679819618, 7245.637718114179, 7545.471816972759, 7553.64034473778, 7565.810854728676, 7687.461877668509, 12749.235045896905, 12811.359432028175, 13082.215067096005, 13101.672458188621, 13131.343432828511, 13329.466821327038, 13335.266560338887, 13346.332683365987, 13353.0, 13389.263590502616, 8586.441881277697, 9719.659811906833, 10042.397456152654, 10044.648437304659, 10066.094051535398, 10588.417637030037, 10880.619178328721, 10975.341479511255, 10983.231173817756, 10984.780304393707, 9512.429254244767, 9593.664221752206, 9627.326087173831, 9678.177354924628, 9791.902080979098, 9479.668211612561, 9571.952140239255, 9590.760230994281, 9618.567164477756, 9759.46322952216, 8721.127887211229, 8798.12018798115, 8857.335699822668, 8884.822303554021, 8894.911050889408, 6562.310957349409, 6605.636689982097, 6607.2071351438135, 6647.833804154935, 6724.260331363644, 6377.23473183221, 6428.710708018244, 6447.6131432114225, 6512.446442052478, 6704.363085506869], "value": 5527.941027705933, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.6450605719995, 431.4369747479539, 431.99568004319946, 435.27309393313163, 445.9910801783964, 5230.372355317362, 5273.18265668821, 5279.366476022878, 5292.401167206298, 5322.787088516455, 4868.732219727914, 5184.7148406837605, 5188.766505507252, 5215.0, 5227.18978558324, 4290.935635965448, 4304.2137512932095, 4321.1141715948315, 4324.351347297899, 4325.697201195918, 4303.483581970152, 4311.784410779464, 4313.541281469564, 4316.093620339732, 4324.718893271943, 4310.892227694301, 4358.673099517533, 4360.890977725567, 4372.169287835317, 4388.802503887333, 4138.420621113047, 4250.107477429743, 4333.656566464375, 4346.217680817484, 4361.454818147731, 4097.2996206574235, 4105.44576482174, 4114.485689288839, 4141.0, 4145.7719825409595, 5141.177411614124, 5180.585553155776, 5183.429822719498, 5192.428832828386, 5240.9213861792105, 4966.701997880139, 5090.338256026693, 5120.206368012964, 5129.589632829365, 5153.994970980661, 5505.284313039279, 5509.421510741355, 5526.198701188305, 5550.27846379968, 5562.249096372019, 4632.536746325374, 4635.745034023127, 4644.976775116136, 4657.764273148874, 4667.369905062841, 5408.323959505062, 5475.698836563987, 5525.480492864454, 5561.193626924073, 5658.377578466366, 4673.462551806518, 4688.523115218695, 4694.178518759203, 4703.506131856174, 4750.714957102516, 4781.545753153445, 4785.090832741768, 4805.67843842946, 4806.591439727592, 4823.397075365579, 4957.082939656175, 4978.7120546077895, 4993.275974983607, 5049.671771334852, 5077.923831142536, 5341.946580534222, 5408.107662235766, 5414.675119492843, 5422.322209723785, 5432.91850622241, 1615.4749706345485, 1638.4019832761194, 1640.8769342299374, 1661.2939500712148, 1674.831093733618, 1275.457930379585, 1286.395394164741, 1308.3523655790445, 1314.3691028306466, 1316.8280230594778, 5400.918986215132, 5418.295621569249, 5422.213779002102, 5429.728513574306, 5438.374586922476, 5583.330000399978, 5649.0, 5668.121441176541, 5671.6597004179885, 5707.343655479673, 5185.896282074337, 5330.920940833078, 5363.946360536344, 5418.674879507243, 5437.646552974044, 2937.8090424122365, 2943.484890144216, 2943.67619561848, 2947.8083924545267, 2964.5986750731977, 5588.441155884379, 5759.473739459047, 5769.423057694197, 5776.5089967352405, 5835.35811060783, 5721.771129154788, 5741.368449470555, 5759.280089988752, 5763.530299773531, 5781.063343779881, 5722.2561067061015, 5736.275269247074, 5792.333881603669, 5814.476697097281, 5820.476157145792, 5249.501297376743, 5524.779008839601, 5541.0, 5567.805126820542, 5573.832785016456, 5311.654742441729, 5462.808801691922, 5483.506484416422, 5497.8075767347955, 5529.253550770755, 5614.691191984317, 5675.659460432387, 5750.223719797774, 5762.654240745569, 5801.477866991822, 4656.8602941911795, 4657.604103651092, 4686.711154432558, 4692.296155576691, 4708.340832283415, 5365.913859064544, 5624.409437009055, 5656.321241451053, 5665.971670141623, 5675.31896172462, 5437.945620543902, 5449.618526703092, 5473.452654734495, 5478.67127972307, 5515.806946756844, 5420.937170498656, 5456.372517160577, 5468.828079713836, 5471.480209380103, 5490.423505531861, 5165.276861239355, 5477.54914403923, 5505.889882202254, 5525.226468294522, 5535.446455354432, 5457.317835270591, 5469.562435005269, 5502.9174562382395, 5525.419830917856, 5557.610967232255, 5163.483651634957, 5385.542228910586, 5394.892102158014, 5402.594805389533, 5452.809151679672], "value": 4413.8180247984155, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [854.7136709202417, 884.1423818895673, 904.3669431398021, 912.1152482092368, 939.1969865764769, 17509.474715758533, 18436.354727584538, 18547.90726046371, 18550.536236594093, 18591.25634974601, 14524.782128268058, 17138.571535711613, 17224.13879306036, 17284.0, 17292.654146917084, 889.1286539191597, 910.1171863292628, 911.3392790227099, 912.8356895758761, 913.228322067855, 924.0205382294789, 925.3245131054334, 926.6200857648365, 927.1609193679697, 927.8144371125768, 968.5351031504882, 973.352720440906, 974.2741657465162, 974.7319487141058, 974.8342781727088, 960.0639376607821, 962.2927148545848, 962.5187406296851, 962.9374090684083, 964.320154291223, 702.3503259485007, 702.4977141343963, 705.7706245470191, 706.1737766812842, 706.6608028146467, 17537.386191483238, 17542.824571754245, 17587.208575614128, 17737.911310443495, 17769.911150444295, 17318.39385621497, 17455.97725035541, 17480.125993700392, 18063.72904406435, 18342.90828545862, 13856.307184640727, 13969.511067112704, 14117.152970821784, 14173.645658858508, 14202.50291239812, 4096.5903409658795, 4181.916361672749, 4195.832166713328, 4199.0, 4240.0, 47322.526774732156, 56310.43689563134, 79170.0, 82585.17414825835, 83265.0, 13679.794803077963, 13990.230537320545, 13992.16047037181, 14031.298435078204, 14172.64568385778, 26029.73970260311, 26212.344691382867, 26334.47331053368, 26483.0, 26535.73464265371, 8879.156480134377, 8935.731928042169, 8996.955015225012, 9034.683786067457, 9331.486768227676, 5064.49355064498, 5089.703782833957, 5178.818741344035, 5198.610104242121, 5313.282706834528, 3786.772793632336, 3881.0879443330796, 3904.7461914975434, 3918.040080180374, 3948.0524674078015, 659.1003280522053, 668.9130413046273, 677.2381071294793, 685.1640997982454, 690.4062506244626, 839.0686338164633, 850.2432834777053, 853.8377708235415, 881.2333270055093, 888.9199972002551, 11289.266197697123, 11423.0, 11521.654350369503, 11758.35329056893, 11961.880381196077, 781.6131015147424, 798.660569258063, 802.7270727952524, 811.5860910935465, 825.8513467575895, 5641.633293835969, 5694.430556944272, 5751.3673495916255, 5794.275715535558, 5822.0975748758165, 78823.60588197137, 80481.0, 80977.0, 84416.0, 86444.56777716072, 57747.0, 70222.29777702158, 70603.0288119837, 72086.0, 72496.0, 63179.36820631735, 63531.0, 65024.0, 65239.673801630684, 67469.66265168643, 10905.454727263446, 10906.945465272624, 10917.23579349438, 11161.218714689894, 11266.436678166223, 45644.0, 45762.0, 46281.0, 46540.53459465497, 46803.765981169876, 52611.0, 52992.73503632457, 53087.0, 53964.73017635044, 55909.0, 11981.460834262654, 12093.213941093802, 12357.567485137977, 12399.566015189786, 12612.495500180257, 14354.210518421587, 14508.637284067983, 14589.0, 14739.631509212355, 14912.62718432048, 14041.1575305482, 14306.713865722835, 15572.84427155714, 15804.36782528686, 15920.681586368439, 14550.563483095524, 14828.555143345286, 15430.845691542941, 16255.59361015984, 16603.086830224453, 14988.550343489713, 15569.922150389175, 15654.765178522104, 16683.582910426852, 16870.746938796172, 11146.609868654557, 11310.60412885545, 12005.279683219034, 12139.635810925687, 12299.385030748248, 11660.88339116598, 12501.874981250072, 12574.622761317176, 13416.731665366833, 14032.08791428554], "value": 8057.484335516291, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1455.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 113.0, 113.0, 112.0, 116.0, 112.0, 111.0, 113.0, 113.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 119.0, 118.0, 152.0, 116.0, 121.0, 120.0, 115.0, 136.0, 114.0], "value": 126.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 161.0, 161.0, 160.0, 160.0, 161.0, 160.0, 159.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 109.0, 76.0, 76.0, 77.0, 76.0, 96.0, 75.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 110.0, 82.0, 82.0, 82.0, 95.0, 82.0, 82.0, 94.0], "value": 87.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 112.0, 113.0, 113.0, 113.0], "value": 112.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 145.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 93.0, 94.0, 94.0, 93.0, 94.0, 93.0, 94.0, 93.0], "value": 93.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 53.0, 54.0, 53.0, 55.0, 53.0, 61.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 54.0, 53.0, 52.0, 52.0, 53.0, 53.0, 54.0, 52.0], "value": 52.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 76.0, 79.0, 79.0, 85.0, 79.0, 79.0, 82.0, 79.0, 108.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 119.0, 121.0, 118.0, 117.0, 119.0, 129.0, 130.0, 143.0, 119.0], "value": 123.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 161.0, 155.0, 164.0, 162.0, 157.0, 171.0, 166.0, 155.0], "value": 161.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 59.0, 60.0, 68.0, 60.0, 65.0, 59.0, 58.0, 58.0, 60.0], "value": 60.9, "unit": "score"}]}]} 04:04:31 INFO - Return code: 0 04:04:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:04:31 INFO - # TBPL SUCCESS # 04:04:31 INFO - Running post-action listener: _resource_record_post_action 04:04:31 INFO - [mozharness: 2017-05-29 11:04:31.643474Z] Finished run-tests step (success) 04:04:31 INFO - Running post-run listener: _resource_record_post_run 04:04:31 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 326541312; Read time: 200; Write time: 220716 04:04:31 INFO - TinderboxPrint: CPU usage
13.1% 04:04:31 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 200 04:04:31 INFO - TinderboxPrint: I/O write bytes / time
326,541,312 / 220,716 04:04:31 INFO - TinderboxPrint: CPU idle
8,260.1 (86.9%) 04:04:31 INFO - TinderboxPrint: CPU user
1,198.8 (12.6%) 04:04:31 INFO - TinderboxPrint: Swap in / out
0 / 0 04:04:31 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 446464; Read time: 0; Write time: 56 04:04:31 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 263983104; Read time: 0; Write time: 193004 04:04:32 INFO - Running post-run listener: _upload_blobber_files 04:04:32 INFO - Blob upload gear active. 04:04:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:04:32 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 04:04:32 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'] 04:04:32 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 04:04:32 INFO - (blobuploader) - INFO - Open directory for files ... 04:04:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:04:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:04:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:04:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:04:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:04:33 INFO - (blobuploader) - INFO - Done attempting. 04:04:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:04:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:04:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:04:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:04:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:04:39 INFO - (blobuploader) - INFO - Done attempting. 04:04:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:04:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:04:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:04:40 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:04:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:04:40 INFO - (blobuploader) - INFO - Done attempting. 04:04:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:04:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:04:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:04:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:04:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:04:41 INFO - (blobuploader) - INFO - Done attempting. 04:04:41 INFO - (blobuploader) - INFO - Iteration through files over. 04:04:41 INFO - Return code: 0 04:04:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:04:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:04:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3af53a436d788b870270ab3fbd046d5d802680aed93041760d0fdf9cf533940c53a8eb17605df65c798d4f7797ef5ac441e3214c4845e6bb58534778528459cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/58092186145ac3d31bbc26404a8ded5383cf95ba15a9b581eb688918a58c6abc9cb173077fa94a6ca5b07836f3a54546bddd1770b7005bc1fda263a1812e85ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/012e63ec35351e1708c994e5bd9717db3178778ff039c706f43113931b7bbdeb2ead3c595bba9c4b185da13d67fb329cb6612d95895cec556cff85c40f721213", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/04ee4096ffb86ddf59cd7cab8db28b22b79453c9d5a80dc0872ba40a9683ec912a5405aff71dabc446ec9e78d53c165c4c9616f2d609d5b245f49c034edfbf78"} 04:04:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:04:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:04:41 INFO - Contents: 04:04:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3af53a436d788b870270ab3fbd046d5d802680aed93041760d0fdf9cf533940c53a8eb17605df65c798d4f7797ef5ac441e3214c4845e6bb58534778528459cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/58092186145ac3d31bbc26404a8ded5383cf95ba15a9b581eb688918a58c6abc9cb173077fa94a6ca5b07836f3a54546bddd1770b7005bc1fda263a1812e85ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/012e63ec35351e1708c994e5bd9717db3178778ff039c706f43113931b7bbdeb2ead3c595bba9c4b185da13d67fb329cb6612d95895cec556cff85c40f721213", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/04ee4096ffb86ddf59cd7cab8db28b22b79453c9d5a80dc0872ba40a9683ec912a5405aff71dabc446ec9e78d53c165c4c9616f2d609d5b245f49c034edfbf78"} 04:04:41 INFO - Running post-run listener: copy_logs_to_upload_dir 04:04:41 INFO - Copying logs to upload dir... 04:04:41 INFO - mkdir: /builds/slave/test/build/upload/logs 04:04:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.651912 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-05-29 04:04:40.874406) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-29 04:04:40.877484) ========= 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=4300f881736b422476174874000001bc-1496039964.322098-380254487 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/3af53a436d788b870270ab3fbd046d5d802680aed93041760d0fdf9cf533940c53a8eb17605df65c798d4f7797ef5ac441e3214c4845e6bb58534778528459cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/58092186145ac3d31bbc26404a8ded5383cf95ba15a9b581eb688918a58c6abc9cb173077fa94a6ca5b07836f3a54546bddd1770b7005bc1fda263a1812e85ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/012e63ec35351e1708c994e5bd9717db3178778ff039c706f43113931b7bbdeb2ead3c595bba9c4b185da13d67fb329cb6612d95895cec556cff85c40f721213", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/04ee4096ffb86ddf59cd7cab8db28b22b79453c9d5a80dc0872ba40a9683ec912a5405aff71dabc446ec9e78d53c165c4c9616f2d609d5b245f49c034edfbf78"} build_url:https://queue.taskcluster.net/v1/task/K20kuum8RaOnZ23O64rUIw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011415 build_url: 'https://queue.taskcluster.net/v1/task/K20kuum8RaOnZ23O64rUIw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3af53a436d788b870270ab3fbd046d5d802680aed93041760d0fdf9cf533940c53a8eb17605df65c798d4f7797ef5ac441e3214c4845e6bb58534778528459cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/58092186145ac3d31bbc26404a8ded5383cf95ba15a9b581eb688918a58c6abc9cb173077fa94a6ca5b07836f3a54546bddd1770b7005bc1fda263a1812e85ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/012e63ec35351e1708c994e5bd9717db3178778ff039c706f43113931b7bbdeb2ead3c595bba9c4b185da13d67fb329cb6612d95895cec556cff85c40f721213", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/04ee4096ffb86ddf59cd7cab8db28b22b79453c9d5a80dc0872ba40a9683ec912a5405aff71dabc446ec9e78d53c165c4c9616f2d609d5b245f49c034edfbf78"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-29 04:04:40.904499) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-29 04:04:40.904803) ========= 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=4300f881736b422476174874000001bc-1496039964.322098-380254487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004606 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-29 04:04:40.986766) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-29 04:04:40.987063) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-29 04:04:40.990366) ========= ========= Total master_lag: 0.23 =========